builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0053 starttime: 1492794316.38 results: success (0) buildid: 20170421080219 builduid: 16e682a3cf154e5881af0d2b79d6f0f6 revision: f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.376440) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.376861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.377158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.404212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.404497) ========= 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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners TMPDIR=/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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-04-21 10:05:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-04-21 10:05:16 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179408 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.608996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.609324) ========= 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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners TMPDIR=/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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.027565 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:16.659961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 10:05:16.660364) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7 --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 f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OG6dIzYM7j/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.2uhdNE4fHb/Listeners TMPDIR=/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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-04-21 10:05:16,770 truncating revision to first 12 chars 2017-04-21 10:05:16,770 Setting DEBUG logging. 2017-04-21 10:05:16,770 attempt 1/10 2017-04-21 10:05:16,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f2197e50ffbb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 10:05:18,594 unpacking tar archive at: mozilla-beta-f2197e50ffbb/testing/mozharness/ program finished with exit code 0 elapsedTime=2.107521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 10:05:18.792432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:18.792780) ========= script_repo_revision: f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:18.793179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:18.793455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:05:18.814191) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-21 10:05:18.814590) ========= /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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners TMPDIR=/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:05:19 INFO - MultiFileLogger online at 20170421 10:05:19 in /builds/slave/test 10:05:19 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 10:05:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:19 INFO - {'append_to_log': False, 10:05:19 INFO - 'base_work_dir': '/builds/slave/test', 10:05:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:05:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:19 INFO - 'branch': 'Mozilla-Beta', 10:05:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:19 INFO - 'config_files': ('talos/mac_config.py',), 10:05:19 INFO - 'default_actions': ('clobber', 10:05:19 INFO - 'read-buildbot-config', 10:05:19 INFO - 'download-and-extract', 10:05:19 INFO - 'populate-webroot', 10:05:19 INFO - 'create-virtualenv', 10:05:19 INFO - 'install', 10:05:19 INFO - 'run-tests'), 10:05:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:19 INFO - 'download_minidump_stackwalk': True, 10:05:19 INFO - 'download_symbols': 'ondemand', 10:05:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:19 INFO - 'gecko_profile': False, 10:05:19 INFO - 'gecko_profile_interval': 0, 10:05:19 INFO - 'installer_path': 'installer.exe', 10:05:19 INFO - 'log_level': 'info', 10:05:19 INFO - 'log_name': 'talos', 10:05:19 INFO - 'log_to_console': True, 10:05:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:19 INFO - 'opt_config_files': (), 10:05:19 INFO - 'pip_index': False, 10:05:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:19 INFO - 'cmd': ('bash', 10:05:19 INFO - '-c', 10:05:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:19 INFO - 'enabled': True, 10:05:19 INFO - 'halt_on_failure': False, 10:05:19 INFO - 'name': 'check_screen_resolution'},), 10:05:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:19 INFO - 'cmd': ('bash', 10:05:19 INFO - '-c', 10:05:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:19 INFO - 'enabled': True, 10:05:19 INFO - 'halt_on_failure': False, 10:05:19 INFO - 'name': 'check_screen_resolution'},), 10:05:19 INFO - 'run_cmd_checks_enabled': True, 10:05:19 INFO - 'suite': 'dromaeojs', 10:05:19 INFO - 'system_bits': '32', 10:05:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:19 INFO - 'title': 't-yosemite-r7-0053', 10:05:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:19 INFO - 'use_talos_json': True, 10:05:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:19 INFO - 'work_dir': 'build'} 10:05:19 INFO - [mozharness: 2017-04-21 17:05:19.030412Z] Running clobber step. 10:05:19 INFO - Running pre-action listener: _resource_record_pre_action 10:05:19 INFO - Running main action method: clobber 10:05:19 INFO - rmtree: /builds/slave/test/build 10:05:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:21 INFO - Running post-action listener: _resource_record_post_action 10:05:21 INFO - [mozharness: 2017-04-21 17:05:21.557506Z] Finished clobber step (success) 10:05:21 INFO - [mozharness: 2017-04-21 17:05:21.557633Z] Running read-buildbot-config step. 10:05:21 INFO - Running pre-action listener: _resource_record_pre_action 10:05:21 INFO - Running main action method: read_buildbot_config 10:05:21 INFO - Using buildbot properties: 10:05:21 INFO - { 10:05:21 INFO - "project": "", 10:05:21 INFO - "product": "firefox", 10:05:21 INFO - "script_repo_revision": "production", 10:05:21 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:05:21 INFO - "repository": "", 10:05:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:05:21 INFO - "buildid": "20170421080219", 10:05:21 INFO - "pgo_build": "False", 10:05:21 INFO - "basedir": "/builds/slave/test", 10:05:21 INFO - "buildnumber": 13, 10:05:21 INFO - "slavename": "t-yosemite-r7-0053", 10:05:21 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:05:21 INFO - "platform": "yosemite_r7", 10:05:21 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:05:21 INFO - "branch": "mozilla-beta", 10:05:21 INFO - "repo_path": "releases/mozilla-beta", 10:05:21 INFO - "revision": "f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7", 10:05:21 INFO - "stage_platform": "macosx64", 10:05:21 INFO - "builduid": "16e682a3cf154e5881af0d2b79d6f0f6", 10:05:21 INFO - "slavebuilddir": "test" 10:05:21 INFO - } 10:05:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:05:21 INFO - Running post-action listener: _resource_record_post_action 10:05:21 INFO - [mozharness: 2017-04-21 17:05:21.561017Z] Finished read-buildbot-config step (success) 10:05:21 INFO - [mozharness: 2017-04-21 17:05:21.561130Z] Running download-and-extract step. 10:05:21 INFO - Running pre-action listener: _resource_record_pre_action 10:05:21 INFO - Running main action method: download_and_extract 10:05:21 INFO - mkdir: /builds/slave/test/build/tests 10:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:21 INFO - trying https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:05:21 INFO - Downloading https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:05:22 INFO - Downloaded 1165 bytes. 10:05:22 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:05:22 INFO - Using the following test package requirements: 10:05:22 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:05:22 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:05:22 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:05:22 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:05:22 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:05:22 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:05:22 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:05:22 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:05:22 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:05:22 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:05:22 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:05:22 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:05:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:05:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:05:22 INFO - Fetch https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:05:23 INFO - Expected file size: 51221168 10:05:23 INFO - Obtained file size: 51221168 10:05:39 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:05:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:05:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:05:39 INFO - Fetch https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:05:41 INFO - Expected file size: 51221168 10:05:41 INFO - Obtained file size: 51221168 10:05:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:05:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:05:56 INFO - Fetch https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:05:58 INFO - Expected file size: 14404424 10:05:58 INFO - Obtained file size: 14404424 10:05: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')]} 10:05:58 INFO - trying https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:06:01 INFO - Downloaded 59545934 bytes. 10:06:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:06:01 INFO - mkdir: /builds/slave/test/properties 10:06:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:01 INFO - Contents: 10:06:01 INFO - build_url:https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:06:02 INFO - Running post-action listener: _resource_record_post_action 10:06:02 INFO - Running post-action listener: set_extra_try_arguments 10:06:02 INFO - [mozharness: 2017-04-21 17:06:02.153226Z] Finished download-and-extract step (success) 10:06:02 INFO - [mozharness: 2017-04-21 17:06:02.153355Z] Running populate-webroot step. 10:06:02 INFO - Running pre-action listener: _resource_record_pre_action 10:06:02 INFO - Running main action method: populate_webroot 10:06:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:02 INFO - '--tppagecycles', 10:06:02 INFO - '7'], 10:06:02 INFO - 'tests': ['tsvgm']}}, 10:06:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['damp', 'tps']}, 10:06:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'tests': ['damp', 'tps']}, 10:06:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['dromaeo_dom']}, 10:06:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['basic_compositor_video']}, 10:06:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:06:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['a11yr', 10:06:02 INFO - 'ts_paint', 10:06:02 INFO - 'tpaint', 10:06:02 INFO - 'sessionrestore', 10:06:02 INFO - 'sessionrestore_no_auto_restore', 10:06:02 INFO - 'tabpaint']}, 10:06:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:02 INFO - 'ts_paint', 10:06:02 INFO - 'tpaint', 10:06:02 INFO - 'sessionrestore', 10:06:02 INFO - 'sessionrestore_no_auto_restore', 10:06:02 INFO - 'tabpaint']}, 10:06:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:02 INFO - 'ts_paint', 10:06:02 INFO - 'tpaint', 10:06:02 INFO - 'sessionrestore', 10:06:02 INFO - 'sessionrestore_no_auto_restore', 10:06:02 INFO - 'tabpaint']}, 10:06:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:02 INFO - 'ts_paint', 10:06:02 INFO - 'tpaint', 10:06:02 INFO - 'sessionrestore', 10:06:02 INFO - 'sessionrestore_no_auto_restore', 10:06:02 INFO - 'tabpaint']}, 10:06:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['a11yr', 10:06:02 INFO - 'ts_paint', 10:06:02 INFO - 'tpaint', 10:06:02 INFO - 'sessionrestore', 10:06:02 INFO - 'sessionrestore_no_auto_restore', 10:06:02 INFO - 'tabpaint']}, 10:06:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['a11yr', 10:06:02 INFO - 'ts_paint', 10:06:02 INFO - 'tpaint', 10:06:02 INFO - 'sessionrestore', 10:06:02 INFO - 'sessionrestore_no_auto_restore', 10:06:02 INFO - 'tabpaint']}, 10:06:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['tsvgx', 10:06:02 INFO - 'tsvgr_opacity', 10:06:02 INFO - 'tart', 10:06:02 INFO - 'tscrollx', 10:06:02 INFO - 'cart', 10:06:02 INFO - 'tsvg_static']}, 10:06:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:02 INFO - 'tsvgr_opacity', 10:06:02 INFO - 'tart', 10:06:02 INFO - 'tscrollx', 10:06:02 INFO - 'cart', 10:06:02 INFO - 'tsvg_static']}, 10:06:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'talos_options': ['--disable-e10s'], 10:06:02 INFO - 'tests': ['tp5o']}, 10:06:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:06:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'talos_options': ['--disable-e10s', 10:06:02 INFO - '--xperf_path', 10:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:02 INFO - 'tests': ['tp5n']}, 10:06:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:06:02 INFO - 'talos_options': ['--xperf_path', 10:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:02 INFO - 'tests': ['tp5n']}}, 10:06:02 INFO - 'talos.zip': {'path': '', 10:06:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:02 INFO - Running post-action listener: _resource_record_post_action 10:06:02 INFO - [mozharness: 2017-04-21 17:06:02.171778Z] Finished populate-webroot step (success) 10:06:02 INFO - [mozharness: 2017-04-21 17:06:02.171896Z] Running create-virtualenv step. 10:06:02 INFO - Running pre-action listener: _resource_record_pre_action 10:06:02 INFO - Running main action method: create_virtualenv 10:06:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:02 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 10:06:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:02 INFO - Using real prefix '/tools/python27' 10:06:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:05 INFO - Installing pip.................done. 10:06:05 INFO - Return code: 0 10:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:06:06 INFO - Reading from file tmpfile_stdout 10:06:06 INFO - Output received: 10:06:06 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) 10:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06:06 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')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:06 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 10:06:06 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 10:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:06 INFO - 'HOME': '/Users/cltbld', 10:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PAGER': '/bin/cat', 10:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:06 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - 'XPC_FLAGS': '0x0', 10:06:06 INFO - 'XPC_SERVICE_NAME': '0', 10:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 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 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06:06 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')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:06 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 10:06:06 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 10:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:06 INFO - 'HOME': '/Users/cltbld', 10:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PAGER': '/bin/cat', 10:06:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test', 10:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:06 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - 'XPC_FLAGS': '0x0', 10:06:06 INFO - 'XPC_SERVICE_NAME': '0', 10:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Downloading/unpacking psutil>=3.1.1 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:10 INFO - Installing collected packages: psutil 10:06:10 INFO - Running setup.py install for psutil 10:06:10 INFO - building 'psutil._psutil_osx' extension 10:06:10 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 10:06:10 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 10:06:10 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 10:06:11 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 10:06:11 INFO - building 'psutil._psutil_posix' extension 10:06:11 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 10:06:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:06:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:06:11 INFO - ^ 10:06:11 INFO - 1 warning generated. 10:06:11 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 10:06:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:11 INFO - Successfully installed psutil 10:06:11 INFO - Cleaning up... 10:06:11 INFO - Return code: 0 10:06:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:11 INFO - 'HOME': '/Users/cltbld', 10:06:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:11 INFO - 'LOGNAME': 'cltbld', 10:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:11 INFO - 'MOZ_NO_REMOTE': '1', 10:06:11 INFO - 'NO_EM_RESTART': '1', 10:06:11 INFO - 'PAGER': '/bin/cat', 10:06:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:11 INFO - 'PWD': '/builds/slave/test', 10:06:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:11 INFO - 'SHELL': '/bin/bash', 10:06:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:11 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:11 INFO - 'USER': 'cltbld', 10:06:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:11 INFO - 'XPC_FLAGS': '0x0', 10:06:11 INFO - 'XPC_SERVICE_NAME': '0', 10:06:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06:11 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 10:06:11 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 10:06:11 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 10:06:11 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 10:06:11 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 10:06:11 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 10:06:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:14 INFO - Installing collected packages: mozsystemmonitor 10:06:14 INFO - Running setup.py install for mozsystemmonitor 10:06:14 INFO - Successfully installed mozsystemmonitor 10:06:14 INFO - Cleaning up... 10:06:14 INFO - Return code: 0 10:06:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06:14 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')]} 10:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:15 INFO - 'HOME': '/Users/cltbld', 10:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PAGER': '/bin/cat', 10:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:15 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - 'XPC_FLAGS': '0x0', 10:06:15 INFO - 'XPC_SERVICE_NAME': '0', 10:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:15 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 10:06:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:18 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 10:06:18 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 10:06:18 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 10:06:18 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 10:06:18 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 10:06:18 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 10:06:19 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:19 INFO - warning: no files found matching '*.txt' 10:06:19 INFO - no previously-included directories found matching 'build' 10:06:19 INFO - no previously-included directories found matching 'dist' 10:06:19 INFO - no previously-included directories found matching '.git*' 10:06:19 INFO - Installing collected packages: jsonschema, functools32 10:06:19 INFO - Running setup.py install for functools32 10:06:19 INFO - warning: no files found matching '*.txt' 10:06:19 INFO - no previously-included directories found matching 'build' 10:06:19 INFO - no previously-included directories found matching 'dist' 10:06:19 INFO - no previously-included directories found matching '.git*' 10:06:19 INFO - Successfully installed jsonschema functools32 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:19 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')]} 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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')]} 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:19 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 10:06:19 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 10:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:19 INFO - 'HOME': '/Users/cltbld', 10:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:19 INFO - 'LOGNAME': 'cltbld', 10:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:19 INFO - 'MOZ_NO_REMOTE': '1', 10:06:19 INFO - 'NO_EM_RESTART': '1', 10:06:19 INFO - 'PAGER': '/bin/cat', 10:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:19 INFO - 'PWD': '/builds/slave/test', 10:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:19 INFO - 'SHELL': '/bin/bash', 10:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:19 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:19 INFO - 'USER': 'cltbld', 10:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:19 INFO - 'XPC_FLAGS': '0x0', 10:06:19 INFO - 'XPC_SERVICE_NAME': '0', 10:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:19 INFO - Cleaning up... 10:06:19 INFO - Return code: 0 10:06:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:19 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')]} 10:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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')]} 10:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:19 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:19 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 10:06:19 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 10:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:19 INFO - 'HOME': '/Users/cltbld', 10:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:19 INFO - 'LOGNAME': 'cltbld', 10:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:19 INFO - 'MOZ_NO_REMOTE': '1', 10:06:19 INFO - 'NO_EM_RESTART': '1', 10:06:19 INFO - 'PAGER': '/bin/cat', 10:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:19 INFO - 'PWD': '/builds/slave/test', 10:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:19 INFO - 'SHELL': '/bin/bash', 10:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:19 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:19 INFO - 'USER': 'cltbld', 10:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:19 INFO - 'XPC_FLAGS': '0x0', 10:06:19 INFO - 'XPC_SERVICE_NAME': '0', 10:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:20 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 10:06:20 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 10:06:20 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 10:06:20 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 10:06:20 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 10:06:20 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 10:06:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:22 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 10:06:22 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 10:06:22 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 10:06:22 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 10:06:22 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 10:06:22 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 10:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:23 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 10:06:23 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 10:06:23 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 10:06:23 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 10:06:23 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 10:06:23 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 10:06:23 INFO - Downloading docopt-0.6.1.tar.gz 10:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:24 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:24 INFO - Running setup.py install for blobuploader 10:06:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:24 INFO - Running setup.py install for requests 10:06:24 INFO - Running setup.py install for docopt 10:06:24 INFO - Successfully installed blobuploader requests docopt 10:06:24 INFO - Cleaning up... 10:06:24 INFO - Return code: 0 10:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:24 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:24 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 10:06:24 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 10:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:24 INFO - 'HOME': '/Users/cltbld', 10:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:24 INFO - 'LOGNAME': 'cltbld', 10:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:24 INFO - 'MOZ_NO_REMOTE': '1', 10:06:24 INFO - 'NO_EM_RESTART': '1', 10:06:24 INFO - 'PAGER': '/bin/cat', 10:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:24 INFO - 'PWD': '/builds/slave/test', 10:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:24 INFO - 'SHELL': '/bin/bash', 10:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:24 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:24 INFO - 'USER': 'cltbld', 10:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:24 INFO - 'XPC_FLAGS': '0x0', 10:06:24 INFO - 'XPC_SERVICE_NAME': '0', 10:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-zt0xzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-HRqTu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-ORkKZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-zdPatb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-kxrvxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-bFDFEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-pf59qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:25 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-n4ZC2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-V9yB4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-eoftEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-MnkHRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-f_wNOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-rxnEb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-ZasfaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-riLgke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-cdIimI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:26 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-jl5gkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:26 INFO - Running setup.py install for manifestparser 10:06:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozcrash 10:06:27 INFO - Running setup.py install for mozdebug 10:06:27 INFO - Running setup.py install for mozdevice 10:06:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozfile 10:06:27 INFO - Running setup.py install for mozhttpd 10:06:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozinfo 10:06:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:27 INFO - Running setup.py install for mozInstall 10:06:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for mozleak 10:06:28 INFO - Running setup.py install for mozlog 10:06:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for moznetwork 10:06:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for mozprocess 10:06:28 INFO - Running setup.py install for mozprofile 10:06:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:28 INFO - Running setup.py install for mozrunner 10:06:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:29 INFO - Running setup.py install for mozscreenshot 10:06:29 INFO - Running setup.py install for moztest 10:06:29 INFO - Running setup.py install for mozversion 10:06:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:29 INFO - Cleaning up... 10:06:29 INFO - Return code: 0 10:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:29 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:29 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 10:06:29 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 10:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:29 INFO - 'HOME': '/Users/cltbld', 10:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:29 INFO - 'LOGNAME': 'cltbld', 10:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:29 INFO - 'MOZ_NO_REMOTE': '1', 10:06:29 INFO - 'NO_EM_RESTART': '1', 10:06:29 INFO - 'PAGER': '/bin/cat', 10:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:29 INFO - 'PWD': '/builds/slave/test', 10:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:29 INFO - 'SHELL': '/bin/bash', 10:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:29 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:29 INFO - 'USER': 'cltbld', 10:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:29 INFO - 'XPC_FLAGS': '0x0', 10:06:29 INFO - 'XPC_SERVICE_NAME': '0', 10:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:29 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-iyE4QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:29 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)) 10:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:29 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-uUUfrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-dCFKyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-zi26ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-zRtHRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-00hmCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-BQT6GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-bu0Q6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-OomfFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-TeuZNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-VwMVXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:30 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)) 10:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:30 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-kRDo7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 10:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:31 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-EcI0nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:31 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)) 10:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:31 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-tCS85c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:31 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)) 10:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:31 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-ArQ_N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:31 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)) 10:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:31 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-JfZOsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:31 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)) 10:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:31 INFO - Running setup.py (path:/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/pip-WoOGAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:31 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)) 10:06:31 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)) 10:06:31 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)) 10:06:31 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)) 10:06:31 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)) 10:06:31 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)) 10:06:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:34 INFO - Downloading blessings-1.6.tar.gz 10:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:34 INFO - Installing collected packages: blessings 10:06:34 INFO - Running setup.py install for blessings 10:06:34 INFO - Successfully installed blessings 10:06:34 INFO - Cleaning up... 10:06:34 INFO - Return code: 0 10:06:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:34 INFO - Reading from file tmpfile_stdout 10:06:34 INFO - Current package versions: 10:06:34 INFO - blessings == 1.6 10:06:34 INFO - blobuploader == 1.2.4 10:06:34 INFO - docopt == 0.6.1 10:06:34 INFO - functools32 == 3.2.3-2 10:06:34 INFO - jsonschema == 2.5.1 10:06:34 INFO - manifestparser == 1.1 10:06:34 INFO - mozInstall == 1.12 10:06:34 INFO - mozcrash == 1.0 10:06:34 INFO - mozdebug == 0.1 10:06:34 INFO - mozdevice == 0.49 10:06:34 INFO - mozfile == 1.2 10:06:34 INFO - mozhttpd == 0.7 10:06:34 INFO - mozinfo == 0.9 10:06:34 INFO - mozleak == 0.1 10:06:34 INFO - mozlog == 3.4 10:06:34 INFO - moznetwork == 0.27 10:06:34 INFO - mozprocess == 0.25 10:06:34 INFO - mozprofile == 0.28 10:06:34 INFO - mozrunner == 6.13 10:06:34 INFO - mozscreenshot == 0.1 10:06:34 INFO - mozsystemmonitor == 0.3 10:06:34 INFO - moztest == 0.8 10:06:34 INFO - mozversion == 1.4 10:06:34 INFO - psutil == 3.1.1 10:06:34 INFO - requests == 1.2.3 10:06:34 INFO - wsgiref == 0.1.2 10:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:34 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')]} 10:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:34 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')]} 10:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:34 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 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06:34 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 10:06:34 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 10:06:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:34 INFO - 'HOME': '/Users/cltbld', 10:06:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:34 INFO - 'LOGNAME': 'cltbld', 10:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:34 INFO - 'MOZ_NO_REMOTE': '1', 10:06:34 INFO - 'NO_EM_RESTART': '1', 10:06:34 INFO - 'PAGER': '/bin/cat', 10:06:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:34 INFO - 'PWD': '/builds/slave/test', 10:06:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:34 INFO - 'SHELL': '/bin/bash', 10:06:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:34 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:34 INFO - 'USER': 'cltbld', 10:06:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:34 INFO - 'XPC_FLAGS': '0x0', 10:06:34 INFO - 'XPC_SERVICE_NAME': '0', 10:06:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 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)) 10:06:35 INFO - Cleaning up... 10:06:35 INFO - Return code: 0 10:06:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100cffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d02768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9143cc5b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, '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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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 10:06: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', 'jsonschema'] in /builds/slave/test/build 10:06: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 jsonschema 10:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:35 INFO - 'HOME': '/Users/cltbld', 10:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:35 INFO - 'LOGNAME': 'cltbld', 10:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:35 INFO - 'MOZ_NO_REMOTE': '1', 10:06:35 INFO - 'NO_EM_RESTART': '1', 10:06:35 INFO - 'PAGER': '/bin/cat', 10:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:35 INFO - 'PWD': '/builds/slave/test', 10:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:35 INFO - 'SHELL': '/bin/bash', 10:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:35 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:35 INFO - 'USER': 'cltbld', 10:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:35 INFO - 'XPC_FLAGS': '0x0', 10:06:35 INFO - 'XPC_SERVICE_NAME': '0', 10:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:35 INFO - Cleaning up... 10:06:35 INFO - Return code: 0 10:06:35 INFO - Running post-action listener: _resource_record_post_action 10:06:35 INFO - Running post-action listener: _start_resource_monitoring 10:06:35 INFO - Starting resource monitoring. 10:06:35 INFO - [mozharness: 2017-04-21 17:06:35.435108Z] Finished create-virtualenv step (success) 10:06:35 INFO - [mozharness: 2017-04-21 17:06:35.436067Z] Running install step. 10:06:35 INFO - Running pre-action listener: _resource_record_pre_action 10:06:35 INFO - Running main action method: install 10:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:35 INFO - Reading from file tmpfile_stdout 10:06:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:35 INFO - Reading from file tmpfile_stdout 10:06:35 INFO - Output received: 10:06:35 INFO - Usage: mozinstall [options] installer 10:06:35 INFO - Options: 10:06:35 INFO - -h, --help show this help message and exit 10:06:35 INFO - -d DEST, --destination=DEST 10:06:35 INFO - Directory to install application into. [default: 10:06:35 INFO - "/builds/slave/test"] 10:06:35 INFO - --app=APP Application being installed. [default: firefox] 10:06:35 INFO - mkdir: /builds/slave/test/build/application 10:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:06:50 INFO - Reading from file tmpfile_stdout 10:06:50 INFO - Output received: 10:06:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:06:50 INFO - Running post-action listener: _resource_record_post_action 10:06:50 INFO - [mozharness: 2017-04-21 17:06:50.628594Z] Finished install step (success) 10:06:50 INFO - [mozharness: 2017-04-21 17:06:50.628736Z] Running run-tests step. 10:06:50 INFO - Running pre-action listener: _resource_record_pre_action 10:06:50 INFO - Running main action method: run_tests 10:06:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:50 INFO - 2017-04-21 10:06:50.643 screenresolution[1629:7513] starting screenresolution argv=screenresolution get 10:06:50 INFO - 2017-04-21 10:06:50.646 screenresolution[1629:7513] Display 0: 1600x1200x32@60 10:06:50 INFO - 2017-04-21 10:06:50.652 screenresolution[1630:7515] starting screenresolution argv=screenresolution list 10:06:50 INFO - Available Modes on Display 0 10:06:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:50 INFO - Intel Iris: 10:06:50 INFO - Chipset Model: Intel Iris 10:06:50 INFO - Type: GPU 10:06:50 INFO - Bus: Built-In 10:06:50 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:50 INFO - Vendor: Intel (0x8086) 10:06:50 INFO - Device ID: 0x0a2e 10:06:50 INFO - Revision ID: 0x0009 10:06:50 INFO - Displays: 10:06:50 INFO - Display: 10:06:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:50 INFO - Display Serial Number: 1600x1200 60 10:06:50 INFO - Main Display: Yes 10:06:50 INFO - Mirror: Off 10:06:50 INFO - Online: Yes 10:06:50 INFO - Rotation: Supported 10:06:50 INFO - Return code: 0 10:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:50 INFO - Python 2.7.3 10:06:50 INFO - Return code: 0 10:06:50 INFO - grabbing minidump binary from tooltool 10:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:50 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 0x100addd30>, '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 0x100a04db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ad2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:50 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 10:06:50 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 10:06:50 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 10:06:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:51 INFO - Return code: 0 10:06:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:06:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:51 INFO - ENV: RUST_BACKTRACE is now 1 10:06:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:06:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:51 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/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--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 10:06:51 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/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --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 10:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OG6dIzYM7j/Render', 10:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:51 INFO - 'HOME': '/Users/cltbld', 10:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:51 INFO - 'LOGNAME': 'cltbld', 10:06:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:51 INFO - 'MOZ_NO_REMOTE': '1', 10:06:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:51 INFO - 'NO_EM_RESTART': '1', 10:06:51 INFO - 'PAGER': '/bin/cat', 10:06:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:51 INFO - 'PWD': '/builds/slave/test', 10:06:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:51 INFO - 'RUST_BACKTRACE': '1', 10:06:51 INFO - 'SHELL': '/bin/bash', 10:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2uhdNE4fHb/Listeners', 10:06:51 INFO - 'TMPDIR': '/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/', 10:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:51 INFO - 'USER': 'cltbld', 10:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:51 INFO - 'XPC_FLAGS': '0x0', 10:06:51 INFO - 'XPC_SERVICE_NAME': '0', 10:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:51 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/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--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 10:06:51 INFO - mozversion application_buildid: 20170421080219 10:06:51 INFO - mozversion application_changeset: f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7 10:06:51 INFO - mozversion application_display_name: Firefox 10:06:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:51 INFO - mozversion application_name: Firefox 10:06:51 INFO - mozversion application_remotingname: firefox 10:06:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:51 INFO - mozversion application_vendor: Mozilla 10:06:51 INFO - mozversion application_version: 54.0 10:06:51 INFO - mozversion platform_buildid: 20170421080219 10:06:51 INFO - mozversion platform_changeset: f2197e50ffbb1b06129a4fd19ef94c3ef7a7a7e7 10:06:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:51 INFO - mozversion platform_version: 54.0 10:06:51 INFO - using testdate: 1492794411 10:06:51 INFO - actual date: 1492794411 10:06:51 INFO - starting webserver on 'localhost:49240' 10:06:51 INFO - SUITE-START | Running 2 tests 10:06:51 INFO - TEST-START | dromaeo_css 10:06:51 INFO - operating with platform_type : mac_ 10:06:51 INFO - Initialising browser for dromaeo_css test... 10:06:51 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/tmpd9DguY/profile http://localhost:49240/getInfo.html) 10:06:53 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 10:06:53 INFO - PROCESS | 1640 | colorDepth:24 10:06:53 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 10:06:53 INFO - PROCESS | 1640 | __metrics 10:06:53 INFO - PROCESS | 1640 | 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" 10:06:53 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:54 INFO - TEST-INFO | 1640: exit 0 10:06:54 INFO - Browser initialized. 10:06:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:54 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/tmpd9DguY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:06 INFO - PROCESS | 1643 | RSS: Main: 165076992 10:07:06 INFO - PROCESS | 1643 | 10:10:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 10:10:12 INFO - PROCESS | 1643 | RSS: Main: 340287488 10:10:12 INFO - PROCESS | 1643 | 10:13:15 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 10:13:15 INFO - PROCESS | 1643 | RSS: Main: 306089984 10:13:15 INFO - PROCESS | 1643 | 10:16:18 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 10:16:18 INFO - PROCESS | 1643 | RSS: Main: 286044160 10:16:18 INFO - PROCESS | 1643 | 10:19:21 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 10:19:22 INFO - PROCESS | 1643 | RSS: Main: 267583488 10:19:22 INFO - PROCESS | 1643 | 10:22:25 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 10:22:26 INFO - PROCESS | 1643 | RSS: Main: 274374656 10:22:26 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 10:25:29 INFO - PROCESS | 1643 | RSS: Main: 476196864 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | __start_tp_report 10:25:29 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 10:25:29 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 10:25:29 INFO - PROCESS | 1643 | |i|pagename|runs| 10:25:29 INFO - PROCESS | 1643 | |0;dojo.html;3521.9647803521957;3565.3760591896416;3580.2660454606826;3584.7311451641126;3644.9453258201133;5670.6030577859565;6136.447719705226;6149.723262453183;6159.10692949522;6194.070889366597;6100.908486372697;6136.662483563402;6158.322584515699;6160.815175544741;6164.321924588303;5492.725363731817;5506.476884695968;5525.475079867406;5564.081926482146;5662.858428539299;5369;5443.700596467193;5634.9718251408685;5644.943550564483;5651.2370829937845;4701.576858082772;5481.588880833953;5509.614326997112;5520;5531.529819965308;5562.749676264558;5566.832995010156;5595.076812325961;5596.384397716248;5609.691466969315;5470.8085217017615;5548.0845660465975;5552.972235138839;5575;5593.993081245374;5876.177335173079;5916.645001299893;5989.011813050842;6151.569390142692;6171.598846075036;6351.618902865796;6387.457066149383;6416.807495775134;6440.967795161041;6452.193475815523;6469.385408386196;6494.5453818232745;6518.57629254097;6524.445422139124;6525.543211975164;5991.7902873399225;6181.536384771115;6183.9381606183815;6239.563230573907;6293.622382657055;5483.725813709299;6412.807615771534;6431.356864313531;6480.351964803482;6591.340865913467;6384.3934826191435;6396.872062558723;6405.839854003594;6410.647414392253;6442;6412.903806442907;6416.679166041679;6463.870722585522;6464.22429308486;6464.353564643498;6309.116723658692;6363.936360636427;6369.108324834527;6378.904316435257;6401.55189136756;6317.431431171217;6344.365563443619;6372.490200784019;6379.840503987438;6385.5210859185745;5180.922286165711;5187.118189907725;5194.142966410575;5196.558292545101;5197.8180763673845;4627.490975992638;4638.768061596974;4722.905541889143;4758.690685105457;4815.879603009883;6325.177726895474;6340.492760579143;6349.873002539924;6355.3644635537;6364.981602943507;6497.057926600616;6512.446442052384;6519.7392104315295;6523.836904077436;6527.34726527353;6070.817875463743;6072.544559157993;6128.075379514901;6321.462675672527;6349.238091429058;5727.31272247333;5755.59710820247;5825.941740582624;5832.62087964281;5852.707364631751;6840.863182736317;6893.689783959834;6896.069030680794;6905.102336696398;6916.930830691729;6029.155918171372;6417.294097649162;6515.641639709672;6518.771842985662;6537.70580323877;6509.967450162719;6565.770198043046;6742.123523941857;6768.661566921733;6851.3491218334175;6425.775097871552;6440.098386225838;6443.355664433519;6448.355164483514;6449.774257900951;6320.905186422299;6440.227172739301;6496.740130394731;6522.05430212626;6535.705893234721;6254.781082662085;6301.180846489927;6329.968350158219;6347.460465860454;6389.073584330153;6404.583702059351;6417.358264173546;6418.582792118497;6422.614643121241;6427.935720642734;6431.035344698333;6433.903491447539;6439.903401448888;6445.903311450238;6446.967765161145;5270.367555893164;6253.3121356651645;6267.592606480564;6305.558610897193;6339.207599050119;6372.55392122547;6400.423961843457;6403.199600049994;6406.743730250924;6419.935800641933 10:25:29 INFO - PROCESS | 1643 | |1;ext.html;754.6226886556722;812.9146439623838;830.5598033042486;908.2007833106865;916.0793402630355;29794.808207671693;41781;42000.369994450106;42071.15857682844;42273.57726422735;42925.7853710731;43033.35449968253;43094.569054309446;43105.35341969873;43142;7943.682252709885;9639.518024098785;9789.314747967645;9803.754906127333;9818.11636952674;8033.477823941425;11716.941415292911;11856.822147667792;12128.272303661764;12131;11928.582499612516;11931.821022684666;11944.223625464361;11952.342621155833;11956.880431195706;11902.523899044028;11930;11934.701632459171;11958.282503049844;11958.40207989597;11561.479733412016;11607.535698572046;11608.129390295762;11627.01170400517;11632.651020469315;40085.599144008476;40272.597274027175;40330.596694032974;40337.59662403397;40499.785006449856;3966.1076257841755;4024.8993775155564;4047.150098479323;4047.635712785834;4067.3695577185586;28875.855620721974;29030.854845725848;30135.849320753256;31036;31082.91209807646;3159.513630006423;3243.2864769750618;3304.1244070321386;3362.0754292569495;3413.6927676508985;363757;365756;366477;366702;367023;53524.732376337866;53746.7312663442;53796.462035379926;53856.19215711767;54014.18978715323;55468;55563;55621.60945976383;55650.16524752132;55722.37804542773;15481.922590386976;15571.221438928009;15572.610684732972;15632.843671563367;15640.608984775472;11229.27009744364;11898.286102833858;13270.601881943558;13277.336133193301;13319.134256273504;10961.561537538568;10961.671149865517;12191.756164876653;12404.689882753004;12407.069469789802;4514.7291162530355;4572.497104395277;5232.39827419844;5247.658902171346;5254.185601231815;1174.8590169179754;1180.1974657232993;1189.5955375172482;1190.214458457414;1196.0610920427423;27203;27657.585136222973;27725.445491090064;27755.444891102066;27825.721742782313;1263.0296737090168;1266.6580023393633;1273.1342686972948;1320.0957344219241;1325.71497128116;14079.014468987278;14221.502247421291;14263.318983750924;14376.784348234785;14403.91970602209;397727;401353;429839;431345;432008;58058.7097064512;58120.128198077065;58171;58198;58271.8345633085;1454.650883787862;1463.985360146385;1512.4630756081433;1516.9165695886832;1517.0291013751207;21268.361949141552;25636.743632563437;26817.463650727266;26956.460870782867;26993.460130797666;46301.536984629725;46345;46408.53591464042;46421.30368044414;46527.76736116298;423189;425194;425267;425815.5801430951;427418;34179.14552136217;34748.65251347555;34989.825050874584;35079.12302192466;35096.64903351036;44299.778501107285;44309.89225269394;45005;45261.77369113265;45808.08383832238;30394.936177233692;30407.695923040486;30440.086797396114;31373.21566960753;31598.684013159575;30151.29575073633;31366;31394.372112558078;31474.527882082246;31540.684593153775;30726.692733072385;35871.82064089663;37421.43867842039;37442.68950586826;37517.81241093777;27690.861545692143;30110.397792043597;30941;31255.06234812959;31434.84282578664;22741.204057857896;22832.880299993627;24181.758182418653;24655;24684.753152468245 10:25:29 INFO - PROCESS | 1643 | |2;jquery.html;388.9805509724513;433.71374892570907;434.4135417186798;442.0716495359744;449.75713114917926;16154.273057712402;21855.235066772668;23438.531229375403;24203.273901782974;24334.51330973382;23861.284161475185;24214;24353.87823060882;24702.011919523244;24821;6774.390304872561;6821.24966253713;6951.860962780741;7034.331738484836;7041.260667629902;4385;4590.288505281686;4645.628349732014;6853.17761868574;6978.057962175092;7839.960800195991;7860.213978602123;7971.362291016705;7979.444008418361;8001.759947201594;7150.356467917886;7462.626868656545;7602.42981776369;7607;7971.880421793649;6601.7359305627715;7001.509894307401;7260.41916646667;7362;7608.695652173907;27490.0378486752;27641;27790.444191116265;27890;27891.860540697166;2931.2232258451527;3022.6523949745842;3037.6506701729363;3114.205877501245;3115.0966219796233;14770.630734231623;14815;14969.550913472613;15261.313240904186;15474.45839395627;2028.8275496582808;2098.3914664747203;2207.249535158038;2243.719535058118;2244.876531790751;163927.1803640986;165804.17097914554;169105.46341804758;175160.12419937947;179843;15301.693966120616;20080.799192008184;20585.176592936416;20768.376948691563;20978;30467.390652187274;30884.382312353628;30913.381732365226;30930.69069309278;31132.221694457367;10471.581136754598;10895.455227238765;11020.338779673246;11026.614068507724;11210.495527701272;9174.357794954289;9223.21602663781;9224.631014759334;9325.626974920928;9361.4383137012;9256.490893000815;9555.856662150074;9625.614975401046;9646.372985756043;9660.17888479473;3997.2605068062503;4016.819243134066;4023.6177563131455;4028.8388464461095;4033.7697002413956;1064.7444613292755;1065.8934106589434;1074.2641290715885;1076.2036093290908;1108.4125413530842;22278.665820012713;22594.98322575488;22681.432964176027;22811.429714256945;22947.196848110238;1050.9369437833755;1054.7415883108688;1072.1797824664138;1076.553230409387;1078.9298695584762;9334.486603236886;10798.082163016075;10858.619948301772;11536;11580.76838463226;713653;737560;766919;785524;785702;159943.20028399784;161025;163922;164640;165575;1190.2798806721983;1239.151181440716;1285.1582213650074;1295.7732396830706;1296.5850927703045;19652.0173991297;19825.30611428593;20223;20241.493962651053;20248.797512024692;45143.77428112838;52619.473805261456;66350.33649663634;66760.66619666871;66821.33178668345;64042.67978660077;88067.55966220128;89519;90767.5461622714;91475.54262228646;7591.58246296459;9327.580258888502;9883.072800803775;11106.666799996014;11700.941495292469;11383.54465821358;12207.267563946192;12527.185732927695;12546.1844980076;12967.22196668203;10889.836652450062;11066.889331106586;11242.437878105899;11341.716457088638;11425.257358271685;10297.12474439681;10418.791624167627;10652.467376630982;10655.946720266658;10757.731056723644;11075.335479871233;11242.044426223863;11404.885951140383;11604.245724027911;11651.475683594428;8465.95767021161;9108.134727200906;9931.453770042717;11427.885721142682;11511.712207194887;10808.135349172204;10904.945475272572;11118.833217501582;11213.495392707511;11306.547738090385 10:25:29 INFO - PROCESS | 1643 | |3;mootools.html;1548.6438119232569;1581.1303782919392;1602;1614.2816446681218;1614.6851363984022;10947.616833410822;11628.244164129326;11643.417829108543;11650.708732281697;11679.941600291986;11097.4451277436;11319.886801131986;11482.770344593124;11648.359340236304;11718.707032324197;2486.3162630276684;2520.6093055576416;2522.3441905104714;2523.356544081266;2525.356034211283;2444.6577479152934;2450.6324051392344;2489.7759201671847;2492.9127480538186;2495.4510007798253;2453.116877923946;2454.1778504201116;2480.516299321633;2487.017628036924;2502.074232533965;2435.3546310227803;2441.0357908625992;2461.7415171407015;2480.516299321624;2487.8756062196817;2452.914148004811;2472.9752702472924;2473.307473907309;2482.7144878338863;2483.962740558893;11201.719957001058;11441.771164576745;11446.94276528612;11458.369789661565;11468.541258349656;5978.312494063195;6141.324454310023;6169.136320915076;6169.629822210682;6178.351273116303;3656.762310449812;3739.2708421857747;3800.410936304877;3831.59768224338;3833.195029043904;1271.0975207602614;1911.4647898588416;1927.5855691026497;1985.1265443204943;1987.3739771971782;13501.662458438519;14097.436102555885;14368.425262989467;14678.706425871529;16144.434944776876;4142.482189726285;4742.976285118552;4921.630877684188;4930.778114984834;4955.281484184773;12257.26456412618;12284.508619655113;12291.877081229073;12308.753824923451;12311.261324320569;5104.489551044866;5259.605529585297;5823.126531020381;5982.850428739229;6059.787907423219;5471.781128754806;5532.861678458071;5566.165075238666;5589.80435684749;5592.916106258409;3960.683145348365;4002.419649150857;4085.85699500522;4089.7137200396282;4089.754614723126;1050.558765318568;1064.6593090211059;1076.6554702495282;1080.184460732158;1085.6417382263835;799.6601444386113;819.2503858968977;837.6314421654453;850.2772643253186;867.9794315781118;6261.624302541771;6743.35938085881;6754.088198093293;6765.661716914135;6766.763163289262;970.4613939263635;976.3897564022486;1003.3177439341172;1003.6938733686296;1016.9474593795534;4232;4278.358246263023;4288.206681763883;4317.762523061262;4375.803088861009;13791.10357826738;14431.35058922351;14458;14471.78292325616;14563.126212427289;13094.738105237842;14325.212113333866;14345.713085738227;14364.784528232085;14380.35288412024;10136.239782016379;10388.428636424918;10433.686989390331;10436.530356133992;10440.791184176274;6789.913613821765;6867.656617169022;6993.755218567326;6999.965000174967;7062.117235345582;12666.87333126657;12933.870661293267;12961.96304295673;12963.092583519441;13105.2136871788;11513.30920144794;11657.125715571197;12767.297798621164;12958.481660733842;13072.411741471466;9250.95374523123;9515.333926625346;9521.714348569554;9529.666461673809;9566.426014439156;10137.341072830242;10520.10579100785;10577.894221057999;10665.253432259668;10679.57281708723;8733.781655458664;8881.333899957659;9019.684311049083;9044.954775226082;9178.67874624385;8779.341549383695;8798.340124490816;8839.381243312906;8847.955760221415;8901.955490222508;8077.31342835842;8228.382871284557;8260.050094238999;8261.710840120568;8283.420160588701;5032.7483625819295;5198.194279886624;5931;6173.98129308677;6205.689715514297;5104.9489505104475;5871.295444546511;5974.133750606225;6230.626162430269;6452.612378501137 10:25:29 INFO - PROCESS | 1643 | |4;prototype.html;335.09858480686944;371.1871002504513;390.2760379496035;391.5946994860319;399.79210810378584;4836.685615434999;4944.6018680939715;5067.189249720045;5100.897982040362;5124.437046700755;4411.735295882249;4427.247367947449;4783.545563171502;4798.712077275357;4816.412960965272;3357.5970883493956;3859.8070096495203;4103.79481025949;4346.413234213388;4363.825446982117;3741.850325986957;3860.4595356650093;4308.46144231971;4399.516053234158;4401.723500184942;3921.450996860442;4052.5815964412513;4382.539833317488;4412.404325416076;4443.755593442359;3966.226585815767;4208.684348673831;4235.882058970499;4353.692542952241;4360.345948107777;3496.965030349689;3503.5970863350785;3765.7552259103345;4159.646430053449;4179.498460184767;4272.5432876096365;4501.2670122003265;4901.137567724242;4910.263460480921;4936.728479933602;4465.084657645175;4896.534829191221;5019.548240658358;5060.84817455477;5061.443970794762;4669.953300466986;5097.643164978453;5360.410354860962;5385.515303622654;5407.513323800877;4170.874873753762;4394.516603173648;4563.018950925533;4733.621310295202;4747.311639812242;4413.713108647928;4738.038725796378;4888.557875426758;5520.503154716095;5643.633163844337;4099.8975025624;4277.529471758104;4837.830675926326;4838.419389673191;4927.310176575283;4894.510548945077;4910.337104490919;4922.547848384664;4962.702237865739;4970.700344202239;4682.531746825291;4917.286993385939;5017.774200161001;5030.84907452777;5094.6943183408375;4629.444466663955;4848.7090774553635;5207.630528109701;5314.627976041717;5392.703401312965;1543.4829332173622;1657.1382880901863;1667.6748034133227;1678.3370568625326;1680.1179380825165;1136.7114863599245;1192.9522819087313;1288.904431233463;1369.9246541440118;1385.7990591364196;4473.510661683892;4479.804895601197;4595.241785105487;4997;5036.597072234213;4458.767393639585;4874.707517548887;4892.951070489321;4955.688550960687;5173;4267.564610488586;4737.28940658904;4873.244647079709;5073.797048118107;5135.897282054413;2586.405126820804;2731.2625591090296;2767.6678798544303;2786.651668541432;2825.5620378841313;5101.387833460009;5363.846772943836;5637.3235211774845;5644.350899646511;5711.514521265739;4587.632989360844;5272.657277276965;5358.892822143535;5497.615166938276;5649.406812284733;5037.3955125384455;5403.351597808288;5553.307050811165;5621.297337832771;5683.8863222736145;4919;5298.403782146797;5335.893282134413;5376.435474275301;5435.619506634498;4380.540043295408;4588.954110458986;4926.581240594446;5261.631685781958;5434.429384914685;5121.948780512147;5586.581006424616;5602.1512900741845;5638.23883775685;5644.983902897354;4114.629683328395;4358.607725304738;4447.865794222453;4743.83396581118;4844.878878028077;4839.782209800497;5112.401919897706;5165.236598419828;5488;5591.329040515164;4612.354270402079;4933.753312334441;5408.486193811582;5418.972905135449;5434.375046869661;4584.495705472462;4976.601871850171;5119.030962041932;5142.254373115802;5441.680574849418;4367.213901497761;4461.556900581286;4527.5019747827055;4768.57082862544;4998.2502624606595;4631.698939568917;4959.504049595012;5403;5414.593905457028;5443.346798384219;4676.3686902267755;4859.9757001216185;5208.427073021889;5270.23581580661;5318.282031925641 10:25:29 INFO - PROCESS | 1643 | |5;yui.html;783.7962129846238;788.2826627768732;851.876477910703;884.2307192742313;914.0174312613942;16553.089580073105;17126.886752361086;17158.39945601904;17250.87869288497;17325.133743312832;12489.750204995895;15962.441314553993;16209.027458352508;16211.51365459038;16237.756433653505;999.0708640963901;1040.1678657074349;1046.2101113659176;1048.52292207046;1052.8681667207782;971.8882328532238;972.1105188752283;973.0998826085843;973.459729849933;976.8095221431823;1084.7884662490817;1089.1341383600056;1089.8528698625664;1091.6943255888364;1094.4363652718855;1083.4853444613825;1085.6417382263835;1085.9239853210279;1086.0605576176629;1087.1574529739437;799.5842162075746;800.3117319105564;800.3877034068884;801.3709238247948;804.7867315161487;17511.299548018193;17652.646947061115;17697.469075927613;17699.29202831898;17750.20124094419;15329.923350383287;15574.925206708285;15698.215089245492;16500.504984850475;16565.751513727304;10964.451777411097;11914.463849126723;12032.39838008096;12166.619405101284;12660.240385576895;3800.410936304877;3902.0830104925603;3937.9212415751526;4024.8993775155855;4168.583141685807;101537.99999999926;106527.46736266346;106597;107257.46371268171;108871;9976.401415915068;11395.487203075716;11736.119791015708;12204.450799714034;12416.00671946242;25877.353066173495;25905.481890362087;25955.870220648776;25963.350916227246;25976.74023259781;8222.17778222173;8374.330053595697;8408.663653453794;8575.485470871643;8597;4240.745555266694;4486.955130448654;4567.36056952027;4650.837220697259;4783.210770222944;3386.5428167197115;3438.535797667333;3443.070370999816;3449.7585169037925;3470.583529976419;606;608.1334098909125;617.163743128055;621.170737066022;627.3506920337429;697.7592730507967;713.9000539924415;722.9349358557755;761.8438220164853;787.8463699578642;8926.776830579287;10602.628907988337;10785.245032847783;11024.50389732464;11366.545338186545;708.19619731605;712.6472396163932;726.7129483853848;732.9560226386434;735.63586024918;5071.290019397287;5251.238570407269;5268.92096618551;5270.631055826056;5445.918311225335;100480.49759751154;108848;109457;110230;117629.23556146664;98158.5092074535;98202.52696209562;98430;99133;101608.98391015995;83297.3340533186;83422.74865877017;83553.32893342098;84820.72768908595;84822;10905.56377744913;11262.831057534308;11367.790262172284;11440.370779606868;11478.88521114778;46410.53589464062;53341;53684.73157634187;54915;55681;70364;73497.53004939978;73819.63090184514;74333.628331858;76285.23714763003;13260.602181934557;13340.19958802475;13417.530386436429;13552.390142443812;14222.928885355506;15170.469033583771;15398.230088495306;15422.305996230421;15764.132972686153;16511.09188994617;13935.30323483842;14046.076708208966;14524.709505810037;14868.40526378976;14924.179170145311;11689.473973671034;14415.927920360331;14573.562793116223;14599.343029563908;15094.39622415091;12411.379431028594;13540.93229533846;13956.79064814049;14049.929750351592;14216.928915355356;10120.696379108638;10771;10828.404437755999;10867.402292873652;11384.772304554028;9217.124373184537;10440.895591044296;10679.626213082505;11464.656060318204;11671.88328116708 10:25:29 INFO - PROCESS | 1643 | __end_tp_report 10:25:29 INFO - PROCESS | 1643 | __start_cc_report 10:25:29 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1815 10:25:29 INFO - PROCESS | 1643 | __end_cc_report 10:25:29 INFO - PROCESS | 1643 | __startTimestamp1492795529318__endTimestamp 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | ------- Summary: start ------- 10:25:29 INFO - PROCESS | 1643 | Number of tests: 6 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:6050.03 Median:6339.21 stddev:654.06 (10.3%) stddev-sans-first:625.27 10:25:29 INFO - PROCESS | 1643 | Values: 3522.0 3565.4 3580.3 3584.7 3644.9 5670.6 6136.4 6149.7 6159.1 6194.1 6100.9 6136.7 6158.3 6160.8 6164.3 5492.7 5506.5 5525.5 5564.1 5662.9 5369.0 5443.7 5635.0 5644.9 5651.2 4701.6 5481.6 5509.6 5520.0 5531.5 5562.7 5566.8 5595.1 5596.4 5609.7 5470.8 5548.1 5553.0 5575.0 5594.0 5876.2 5916.6 5989.0 6151.6 6171.6 6351.6 6387.5 6416.8 6441.0 6452.2 6469.4 6494.5 6518.6 6524.4 6525.5 5991.8 6181.5 6183.9 6239.6 6293.6 5483.7 6412.8 6431.4 6480.4 6591.3 6384.4 6396.9 6405.8 6410.6 6442.0 6412.9 6416.7 6463.9 6464.2 6464.4 6309.1 6363.9 6369.1 6378.9 6401.6 6317.4 6344.4 6372.5 6379.8 6385.5 5180.9 5187.1 5194.1 5196.6 5197.8 4627.5 4638.8 4722.9 4758.7 4815.9 6325.2 6340.5 6349.9 6355.4 6365.0 6497.1 6512.4 6519.7 6523.8 6527.3 6070.8 6072.5 6128.1 6321.5 6349.2 5727.3 5755.6 5825.9 5832.6 5852.7 6840.9 6893.7 6896.1 6905.1 6916.9 6029.2 6417.3 6515.6 6518.8 6537.7 6510.0 6565.8 6742.1 6768.7 6851.3 6425.8 6440.1 6443.4 6448.4 6449.8 6320.9 6440.2 6496.7 6522.1 6535.7 6254.8 6301.2 6330.0 6347.5 6389.1 6404.6 6417.4 6418.6 6422.6 6427.9 6431.0 6433.9 6439.9 6445.9 6447.0 5270.4 6253.3 6267.6 6305.6 6339.2 6372.6 6400.4 6403.2 6406.7 6419.9 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:55249.00 Median:17379.10 stddev:106834.09 (614.7%) stddev-sans-first:107055.44 10:25:29 INFO - PROCESS | 1643 | Values: 754.6 812.9 830.6 908.2 916.1 29794.8 41781.0 42000.4 42071.2 42273.6 42925.8 43033.4 43094.6 43105.4 43142.0 7943.7 9639.5 9789.3 9803.8 9818.1 8033.5 11716.9 11856.8 12128.3 12131.0 11928.6 11931.8 11944.2 11952.3 11956.9 11902.5 11930.0 11934.7 11958.3 11958.4 11561.5 11607.5 11608.1 11627.0 11632.7 40085.6 40272.6 40330.6 40337.6 40499.8 3966.1 4024.9 4047.2 4047.6 4067.4 28875.9 29030.9 30135.8 31036.0 31082.9 3159.5 3243.3 3304.1 3362.1 3413.7 363757.0 365756.0 366477.0 366702.0 367023.0 53524.7 53746.7 53796.5 53856.2 54014.2 55468.0 55563.0 55621.6 55650.2 55722.4 15481.9 15571.2 15572.6 15632.8 15640.6 11229.3 11898.3 13270.6 13277.3 13319.1 10961.6 10961.7 12191.8 12404.7 12407.1 4514.7 4572.5 5232.4 5247.7 5254.2 1174.9 1180.2 1189.6 1190.2 1196.1 27203.0 27657.6 27725.4 27755.4 27825.7 1263.0 1266.7 1273.1 1320.1 1325.7 14079.0 14221.5 14263.3 14376.8 14403.9 397727.0 401353.0 429839.0 431345.0 432008.0 58058.7 58120.1 58171.0 58198.0 58271.8 1454.7 1464.0 1512.5 1516.9 1517.0 21268.4 25636.7 26817.5 26956.5 26993.5 46301.5 46345.0 46408.5 46421.3 46527.8 423189.0 425194.0 425267.0 425815.6 427418.0 34179.1 34748.7 34989.8 35079.1 35096.6 44299.8 44309.9 45005.0 45261.8 45808.1 30394.9 30407.7 30440.1 31373.2 31598.7 30151.3 31366.0 31394.4 31474.5 31540.7 30726.7 35871.8 37421.4 37442.7 37517.8 27690.9 30110.4 30941.0 31255.1 31434.8 22741.2 22832.9 24181.8 24655.0 24684.8 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:43986.56 Median:23649.91 stddev:127074.59 (537.3%) stddev-sans-first:127388.90 10:25:29 INFO - PROCESS | 1643 | Values: 389.0 433.7 434.4 442.1 449.8 16154.3 21855.2 23438.5 24203.3 24334.5 23861.3 24214.0 24353.9 24702.0 24821.0 6774.4 6821.2 6951.9 7034.3 7041.3 4385.0 4590.3 4645.6 6853.2 6978.1 7840.0 7860.2 7971.4 7979.4 8001.8 7150.4 7462.6 7602.4 7607.0 7971.9 6601.7 7001.5 7260.4 7362.0 7608.7 27490.0 27641.0 27790.4 27890.0 27891.9 2931.2 3022.7 3037.7 3114.2 3115.1 14770.6 14815.0 14969.6 15261.3 15474.5 2028.8 2098.4 2207.2 2243.7 2244.9 163927.2 165804.2 169105.5 175160.1 179843.0 15301.7 20080.8 20585.2 20768.4 20978.0 30467.4 30884.4 30913.4 30930.7 31132.2 10471.6 10895.5 11020.3 11026.6 11210.5 9174.4 9223.2 9224.6 9325.6 9361.4 9256.5 9555.9 9625.6 9646.4 9660.2 3997.3 4016.8 4023.6 4028.8 4033.8 1064.7 1065.9 1074.3 1076.2 1108.4 22278.7 22595.0 22681.4 22811.4 22947.2 1050.9 1054.7 1072.2 1076.6 1078.9 9334.5 10798.1 10858.6 11536.0 11580.8 713653.0 737560.0 766919.0 785524.0 785702.0 159943.2 161025.0 163922.0 164640.0 165575.0 1190.3 1239.2 1285.2 1295.8 1296.6 19652.0 19825.3 20223.0 20241.5 20248.8 45143.8 52619.5 66350.3 66760.7 66821.3 64042.7 88067.6 89519.0 90767.5 91475.5 7591.6 9327.6 9883.1 11106.7 11700.9 11383.5 12207.3 12527.2 12546.2 12967.2 10889.8 11066.9 11242.4 11341.7 11425.3 10297.1 10418.8 10652.5 10655.9 10757.7 11075.3 11242.0 11404.9 11604.2 11651.5 8466.0 9108.1 9931.5 11427.9 11511.7 10808.1 10904.9 11118.8 11213.5 11306.5 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6930.35 Median:2491.34 stddev:4296.96 (172.5%) stddev-sans-first:4289.98 10:25:29 INFO - PROCESS | 1643 | Values: 1548.6 1581.1 1602.0 1614.3 1614.7 10947.6 11628.2 11643.4 11650.7 11679.9 11097.4 11319.9 11482.8 11648.4 11718.7 2486.3 2520.6 2522.3 2523.4 2525.4 2444.7 2450.6 2489.8 2492.9 2495.5 2453.1 2454.2 2480.5 2487.0 2502.1 2435.4 2441.0 2461.7 2480.5 2487.9 2452.9 2473.0 2473.3 2482.7 2484.0 11201.7 11441.8 11446.9 11458.4 11468.5 5978.3 6141.3 6169.1 6169.6 6178.4 3656.8 3739.3 3800.4 3831.6 3833.2 1271.1 1911.5 1927.6 1985.1 1987.4 13501.7 14097.4 14368.4 14678.7 16144.4 4142.5 4743.0 4921.6 4930.8 4955.3 12257.3 12284.5 12291.9 12308.8 12311.3 5104.5 5259.6 5823.1 5982.9 6059.8 5471.8 5532.9 5566.2 5589.8 5592.9 3960.7 4002.4 4085.9 4089.7 4089.8 1050.6 1064.7 1076.7 1080.2 1085.6 799.7 819.3 837.6 850.3 868.0 6261.6 6743.4 6754.1 6765.7 6766.8 970.5 976.4 1003.3 1003.7 1016.9 4232.0 4278.4 4288.2 4317.8 4375.8 13791.1 14431.4 14458.0 14471.8 14563.1 13094.7 14325.2 14345.7 14364.8 14380.4 10136.2 10388.4 10433.7 10436.5 10440.8 6789.9 6867.7 6993.8 7000.0 7062.1 12666.9 12933.9 12962.0 12963.1 13105.2 11513.3 11657.1 12767.3 12958.5 13072.4 9251.0 9515.3 9521.7 9529.7 9566.4 10137.3 10520.1 10577.9 10665.3 10679.6 8733.8 8881.3 9019.7 9045.0 9178.7 8779.3 8798.3 8839.4 8848.0 8902.0 8077.3 8228.4 8260.1 8261.7 8283.4 5032.7 5198.2 5931.0 6174.0 6205.7 5104.9 5871.3 5974.1 6230.6 6452.6 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4477.83 Median:4846.79 stddev:1189.17 (24.5%) stddev-sans-first:1151.13 10:25:29 INFO - PROCESS | 1643 | Values: 335.1 371.2 390.3 391.6 399.8 4836.7 4944.6 5067.2 5100.9 5124.4 4411.7 4427.2 4783.5 4798.7 4816.4 3357.6 3859.8 4103.8 4346.4 4363.8 3741.9 3860.5 4308.5 4399.5 4401.7 3921.5 4052.6 4382.5 4412.4 4443.8 3966.2 4208.7 4235.9 4353.7 4360.3 3497.0 3503.6 3765.8 4159.6 4179.5 4272.5 4501.3 4901.1 4910.3 4936.7 4465.1 4896.5 5019.5 5060.8 5061.4 4670.0 5097.6 5360.4 5385.5 5407.5 4170.9 4394.5 4563.0 4733.6 4747.3 4413.7 4738.0 4888.6 5520.5 5643.6 4099.9 4277.5 4837.8 4838.4 4927.3 4894.5 4910.3 4922.5 4962.7 4970.7 4682.5 4917.3 5017.8 5030.8 5094.7 4629.4 4848.7 5207.6 5314.6 5392.7 1543.5 1657.1 1667.7 1678.3 1680.1 1136.7 1193.0 1288.9 1369.9 1385.8 4473.5 4479.8 4595.2 4997.0 5036.6 4458.8 4874.7 4893.0 4955.7 5173.0 4267.6 4737.3 4873.2 5073.8 5135.9 2586.4 2731.3 2767.7 2786.7 2825.6 5101.4 5363.8 5637.3 5644.4 5711.5 4587.6 5272.7 5358.9 5497.6 5649.4 5037.4 5403.4 5553.3 5621.3 5683.9 4919.0 5298.4 5335.9 5376.4 5435.6 4380.5 4589.0 4926.6 5261.6 5434.4 5121.9 5586.6 5602.2 5638.2 5645.0 4114.6 4358.6 4447.9 4743.8 4844.9 4839.8 5112.4 5165.2 5488.0 5591.3 4612.4 4933.8 5408.5 5419.0 5434.4 4584.5 4976.6 5119.0 5142.3 5441.7 4367.2 4461.6 4527.5 4768.6 4998.3 4631.7 4959.5 5403.0 5414.6 5443.3 4676.4 4860.0 5208.4 5270.2 5318.3 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:21912.01 Median:17288.01 stddev:31167.77 (180.3%) stddev-sans-first:31214.83 10:25:29 INFO - PROCESS | 1643 | Values: 783.8 788.3 851.9 884.2 914.0 16553.1 17126.9 17158.4 17250.9 17325.1 12489.8 15962.4 16209.0 16211.5 16237.8 999.1 1040.2 1046.2 1048.5 1052.9 971.9 972.1 973.1 973.5 976.8 1084.8 1089.1 1089.9 1091.7 1094.4 1083.5 1085.6 1085.9 1086.1 1087.2 799.6 800.3 800.4 801.4 804.8 17511.3 17652.6 17697.5 17699.3 17750.2 15329.9 15574.9 15698.2 16500.5 16565.8 10964.5 11914.5 12032.4 12166.6 12660.2 3800.4 3902.1 3937.9 4024.9 4168.6 101538.0 106527.5 106597.0 107257.5 108871.0 9976.4 11395.5 11736.1 12204.5 12416.0 25877.4 25905.5 25955.9 25963.4 25976.7 8222.2 8374.3 8408.7 8575.5 8597.0 4240.7 4487.0 4567.4 4650.8 4783.2 3386.5 3438.5 3443.1 3449.8 3470.6 606.0 608.1 617.2 621.2 627.4 697.8 713.9 722.9 761.8 787.8 8926.8 10602.6 10785.2 11024.5 11366.5 708.2 712.6 726.7 733.0 735.6 5071.3 5251.2 5268.9 5270.6 5445.9 100480.5 108848.0 109457.0 110230.0 117629.2 98158.5 98202.5 98430.0 99133.0 101609.0 83297.3 83422.7 83553.3 84820.7 84822.0 10905.6 11262.8 11367.8 11440.4 11478.9 46410.5 53341.0 53684.7 54915.0 55681.0 70364.0 73497.5 73819.6 74333.6 76285.2 13260.6 13340.2 13417.5 13552.4 14222.9 15170.5 15398.2 15422.3 15764.1 16511.1 13935.3 14046.1 14524.7 14868.4 14924.2 11689.5 14415.9 14573.6 14599.3 15094.4 12411.4 13540.9 13956.8 14049.9 14216.9 10120.7 10771.0 10828.4 10867.4 11384.8 9217.1 10440.9 10679.6 11464.7 11671.9 10:25:29 INFO - PROCESS | 1643 | -------- Summary: end -------- 10:25:29 INFO - PROCESS | 1643 | 10:25:29 INFO - TEST-INFO | 1643: exit 0 10:25:29 INFO - TEST-OK | dromaeo_css | took 1118665ms 10:25:29 INFO - TEST-START | kraken 10:25:29 INFO - operating with platform_type : mac_ 10:25:29 INFO - Initialising browser for kraken test... 10:25:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/tmphZRnnf/profile http://localhost:49240/getInfo.html) 10:25:32 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 10:25:32 INFO - PROCESS | 1652 | colorDepth:24 10:25:32 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 10:25:32 INFO - PROCESS | 1652 | __metrics 10:25:32 INFO - PROCESS | 1652 | 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" 10:25:32 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:32 INFO - TEST-INFO | 1652: exit 0 10:25:32 INFO - Browser initialized. 10:25:32 INFO - Running cycle 1/1 for kraken test... 10:25:32 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/T/tmphZRnnf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:45 INFO - PROCESS | 1654 | RSS: Main: 169328640 10:25:45 INFO - PROCESS | 1654 | 10:25:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:48 INFO - PROCESS | 1654 | RSS: Main: 219648000 10:25:48 INFO - PROCESS | 1654 | 10:25:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 10:25:51 INFO - PROCESS | 1654 | RSS: Main: 229392384 10:25:51 INFO - PROCESS | 1654 | 10:25:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 10:25:55 INFO - PROCESS | 1654 | RSS: Main: 326746112 10:25:55 INFO - PROCESS | 1654 | 10:25:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 10:25:58 INFO - PROCESS | 1654 | RSS: Main: 229343232 10:25:58 INFO - PROCESS | 1654 | 10:26:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:00 INFO - PROCESS | 1654 | RSS: Main: 231149568 10:26:00 INFO - PROCESS | 1654 | 10:26:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:04 INFO - PROCESS | 1654 | RSS: Main: 270168064 10:26:04 INFO - PROCESS | 1654 | 10:26:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:07 INFO - PROCESS | 1654 | RSS: Main: 273547264 10:26:07 INFO - PROCESS | 1654 | 10:26:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 10:26:11 INFO - PROCESS | 1654 | RSS: Main: 268472320 10:26:11 INFO - PROCESS | 1654 | 10:26:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:13 INFO - PROCESS | 1654 | RSS: Main: 249548800 10:26:13 INFO - PROCESS | 1654 | 10:26:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:16 INFO - PROCESS | 1654 | RSS: Main: 249733120 10:26:16 INFO - PROCESS | 1654 | 10:26:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:19 INFO - PROCESS | 1654 | RSS: Main: 258789376 10:26:19 INFO - PROCESS | 1654 | 10:26:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:22 INFO - PROCESS | 1654 | RSS: Main: 274841600 10:26:22 INFO - PROCESS | 1654 | 10:26:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:26 INFO - PROCESS | 1654 | RSS: Main: 267644928 10:26:26 INFO - PROCESS | 1654 | 10:26:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 10:26:28 INFO - PROCESS | 1654 | RSS: Main: 312254464 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | __start_tp_report 10:26:28 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 10:26:28 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 10:26:28 INFO - PROCESS | 1654 | |i|pagename|runs| 10:26:28 INFO - PROCESS | 1654 | |0;ai-astar;115;115;116;115;114;130;167;170;114;115 10:26:28 INFO - PROCESS | 1654 | |1;audio-beat-detection;143;107;108;142;109;108;108;107;128;106 10:26:28 INFO - PROCESS | 1654 | |2;audio-dft;185;184;185;186;184;186;192;225;186;186 10:26:28 INFO - PROCESS | 1654 | |3;audio-fft;84;59;61;90;60;59;60;59;73;74 10:26:28 INFO - PROCESS | 1654 | |4;audio-oscillator;83;69;84;69;69;68;83;69;68;84 10:26:28 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;88;88;90;87;87;88;87;88;88 10:26:28 INFO - PROCESS | 1654 | |6;imaging-darkroom;94;93;94;94;93;94;91;94;93;93 10:26:28 INFO - PROCESS | 1654 | |7;imaging-desaturate;84;83;83;96;128;130;86;86;83;83 10:26:28 INFO - PROCESS | 1654 | |8;json-parse-financial;64;59;60;61;64;63;62;63;62;63 10:26:28 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;54;66;68;62;59;56;57;58;57;57 10:26:28 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;81;88;98;82;83;82;83;83;88;87 10:26:28 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;135;133;142;135;134;133;133;151;195;131 10:26:28 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;162;162;162;163;163;161;162;161;172;162 10:26:28 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;64;64;65;64;63;63;63;63;61;61 10:26:28 INFO - PROCESS | 1654 | __end_tp_report 10:26:28 INFO - PROCESS | 1654 | __start_cc_report 10:26:28 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2175 10:26:28 INFO - PROCESS | 1654 | __end_cc_report 10:26:28 INFO - PROCESS | 1654 | __startTimestamp1492795588042__endTimestamp 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | ------- Summary: start ------- 10:26:28 INFO - PROCESS | 1654 | Number of tests: 14 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:127.10 Median:115.50 stddev:22.34 (19.3%) stddev-sans-first:23.27 10:26:28 INFO - PROCESS | 1654 | Values: 115.0 115.0 116.0 115.0 114.0 130.0 167.0 170.0 114.0 115.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:116.60 Median:108.50 stddev:15.09 (13.9%) stddev-sans-first:12.62 10:26:28 INFO - PROCESS | 1654 | Values: 143.0 107.0 108.0 142.0 109.0 108.0 108.0 107.0 128.0 106.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:189.90 Median:186.00 stddev:12.54 (6.7%) stddev-sans-first:13.17 10:26:28 INFO - PROCESS | 1654 | Values: 185.0 184.0 185.0 186.0 184.0 186.0 192.0 225.0 186.0 186.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:67.90 Median:67.00 stddev:11.65 (17.4%) stddev-sans-first:10.80 10:26:28 INFO - PROCESS | 1654 | Values: 84.0 59.0 61.0 90.0 60.0 59.0 60.0 59.0 73.0 74.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:76.00 stddev:7.68 (10.1%) stddev-sans-first:7.52 10:26:28 INFO - PROCESS | 1654 | Values: 83.0 69.0 84.0 69.0 69.0 68.0 83.0 69.0 68.0 84.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 10:26:28 INFO - PROCESS | 1654 | Values: 88.0 88.0 88.0 90.0 87.0 87.0 88.0 87.0 88.0 88.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:94.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 10:26:28 INFO - PROCESS | 1654 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 91.0 94.0 93.0 93.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:83.50 stddev:18.76 (22.5%) stddev-sans-first:19.53 10:26:28 INFO - PROCESS | 1654 | Values: 84.0 83.0 83.0 96.0 128.0 130.0 86.0 86.0 83.0 83.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.66 (2.6%) stddev-sans-first:1.62 10:26:28 INFO - PROCESS | 1654 | Values: 64.0 59.0 60.0 61.0 64.0 63.0 62.0 63.0 62.0 63.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:58.50 stddev:4.53 (7.7%) stddev-sans-first:4.36 10:26:28 INFO - PROCESS | 1654 | Values: 54.0 66.0 68.0 62.0 59.0 56.0 57.0 58.0 57.0 57.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:5.10 (6.0%) stddev-sans-first:5.15 10:26:28 INFO - PROCESS | 1654 | Values: 81.0 88.0 98.0 82.0 83.0 82.0 83.0 83.0 88.0 87.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:135.00 stddev:19.48 (14.4%) stddev-sans-first:20.49 10:26:28 INFO - PROCESS | 1654 | Values: 135.0 133.0 142.0 135.0 134.0 133.0 133.0 151.0 195.0 131.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:162.00 stddev:3.23 (2.0%) stddev-sans-first:3.41 10:26:28 INFO - PROCESS | 1654 | Values: 162.0 162.0 162.0 163.0 163.0 161.0 162.0 161.0 172.0 162.0 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.29 (2.0%) stddev-sans-first:1.32 10:26:28 INFO - PROCESS | 1654 | Values: 64.0 64.0 65.0 64.0 63.0 63.0 63.0 63.0 61.0 61.0 10:26:28 INFO - PROCESS | 1654 | -------- Summary: end -------- 10:26:28 INFO - PROCESS | 1654 | 10:26:28 INFO - TEST-INFO | 1654: exit 0 10:26:28 INFO - TEST-OK | kraken | took 58967ms 10:26:28 INFO - SUITE-END | took 1177s 10:26:29 INFO - Completed test suite (00:19:37) 10:26:29 INFO - javascript benchmark 10:26:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7912.000406148388, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3521.9647803521957, 3565.3760591896416, 3580.2660454606826, 3584.7311451641126, 3644.9453258201133, 5670.6030577859565, 6136.447719705226, 6149.723262453183, 6159.10692949522, 6194.070889366597, 6100.908486372697, 6136.662483563402, 6158.322584515699, 6160.815175544741, 6164.321924588303, 5492.725363731817, 5506.476884695968, 5525.475079867406, 5564.081926482146, 5662.858428539299, 5369.0, 5443.700596467193, 5634.9718251408685, 5644.943550564483, 5651.2370829937845, 4701.576858082772, 5481.588880833953, 5509.614326997112, 5520.0, 5531.529819965308, 5562.749676264558, 5566.832995010156, 5595.076812325961, 5596.384397716248, 5609.691466969315, 5470.8085217017615, 5548.0845660465975, 5552.972235138839, 5575.0, 5593.993081245374, 5876.177335173079, 5916.645001299893, 5989.011813050842, 6151.569390142692, 6171.598846075036, 6351.618902865796, 6387.457066149383, 6416.807495775134, 6440.967795161041, 6452.193475815523, 6469.385408386196, 6494.5453818232745, 6518.57629254097, 6524.445422139124, 6525.543211975164, 5991.7902873399225, 6181.536384771115, 6183.9381606183815, 6239.563230573907, 6293.622382657055, 5483.725813709299, 6412.807615771534, 6431.356864313531, 6480.351964803482, 6591.340865913467, 6384.3934826191435, 6396.872062558723, 6405.839854003594, 6410.647414392253, 6442.0, 6412.903806442907, 6416.679166041679, 6463.870722585522, 6464.22429308486, 6464.353564643498, 6309.116723658692, 6363.936360636427, 6369.108324834527, 6378.904316435257, 6401.55189136756, 6317.431431171217, 6344.365563443619, 6372.490200784019, 6379.840503987438, 6385.5210859185745, 5180.922286165711, 5187.118189907725, 5194.142966410575, 5196.558292545101, 5197.8180763673845, 4627.490975992638, 4638.768061596974, 4722.905541889143, 4758.690685105457, 4815.879603009883, 6325.177726895474, 6340.492760579143, 6349.873002539924, 6355.3644635537, 6364.981602943507, 6497.057926600616, 6512.446442052384, 6519.7392104315295, 6523.836904077436, 6527.34726527353, 6070.817875463743, 6072.544559157993, 6128.075379514901, 6321.462675672527, 6349.238091429058, 5727.31272247333, 5755.59710820247, 5825.941740582624, 5832.62087964281, 5852.707364631751, 6840.863182736317, 6893.689783959834, 6896.069030680794, 6905.102336696398, 6916.930830691729, 6029.155918171372, 6417.294097649162, 6515.641639709672, 6518.771842985662, 6537.70580323877, 6509.967450162719, 6565.770198043046, 6742.123523941857, 6768.661566921733, 6851.3491218334175, 6425.775097871552, 6440.098386225838, 6443.355664433519, 6448.355164483514, 6449.774257900951, 6320.905186422299, 6440.227172739301, 6496.740130394731, 6522.05430212626, 6535.705893234721, 6254.781082662085, 6301.180846489927, 6329.968350158219, 6347.460465860454, 6389.073584330153, 6404.583702059351, 6417.358264173546, 6418.582792118497, 6422.614643121241, 6427.935720642734, 6431.035344698333, 6433.903491447539, 6439.903401448888, 6445.903311450238, 6446.967765161145, 5270.367555893164, 6253.3121356651645, 6267.592606480564, 6305.558610897193, 6339.207599050119, 6372.55392122547, 6400.423961843457, 6403.199600049994, 6406.743730250924, 6419.935800641933], "value": 6009.681811933126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.6226886556722, 812.9146439623838, 830.5598033042486, 908.2007833106865, 916.0793402630355, 29794.808207671693, 41781.0, 42000.369994450106, 42071.15857682844, 42273.57726422735, 42925.7853710731, 43033.35449968253, 43094.569054309446, 43105.35341969873, 43142.0, 7943.682252709885, 9639.518024098785, 9789.314747967645, 9803.754906127333, 9818.11636952674, 8033.477823941425, 11716.941415292911, 11856.822147667792, 12128.272303661764, 12131.0, 11928.582499612516, 11931.821022684666, 11944.223625464361, 11952.342621155833, 11956.880431195706, 11902.523899044028, 11930.0, 11934.701632459171, 11958.282503049844, 11958.40207989597, 11561.479733412016, 11607.535698572046, 11608.129390295762, 11627.01170400517, 11632.651020469315, 40085.599144008476, 40272.597274027175, 40330.596694032974, 40337.59662403397, 40499.785006449856, 3966.1076257841755, 4024.8993775155564, 4047.150098479323, 4047.635712785834, 4067.3695577185586, 28875.855620721974, 29030.854845725848, 30135.849320753256, 31036.0, 31082.91209807646, 3159.513630006423, 3243.2864769750618, 3304.1244070321386, 3362.0754292569495, 3413.6927676508985, 363757.0, 365756.0, 366477.0, 366702.0, 367023.0, 53524.732376337866, 53746.7312663442, 53796.462035379926, 53856.19215711767, 54014.18978715323, 55468.0, 55563.0, 55621.60945976383, 55650.16524752132, 55722.37804542773, 15481.922590386976, 15571.221438928009, 15572.610684732972, 15632.843671563367, 15640.608984775472, 11229.27009744364, 11898.286102833858, 13270.601881943558, 13277.336133193301, 13319.134256273504, 10961.561537538568, 10961.671149865517, 12191.756164876653, 12404.689882753004, 12407.069469789802, 4514.7291162530355, 4572.497104395277, 5232.39827419844, 5247.658902171346, 5254.185601231815, 1174.8590169179754, 1180.1974657232993, 1189.5955375172482, 1190.214458457414, 1196.0610920427423, 27203.0, 27657.585136222973, 27725.445491090064, 27755.444891102066, 27825.721742782313, 1263.0296737090168, 1266.6580023393633, 1273.1342686972948, 1320.0957344219241, 1325.71497128116, 14079.014468987278, 14221.502247421291, 14263.318983750924, 14376.784348234785, 14403.91970602209, 397727.0, 401353.0, 429839.0, 431345.0, 432008.0, 58058.7097064512, 58120.128198077065, 58171.0, 58198.0, 58271.8345633085, 1454.650883787862, 1463.985360146385, 1512.4630756081433, 1516.9165695886832, 1517.0291013751207, 21268.361949141552, 25636.743632563437, 26817.463650727266, 26956.460870782867, 26993.460130797666, 46301.536984629725, 46345.0, 46408.53591464042, 46421.30368044414, 46527.76736116298, 423189.0, 425194.0, 425267.0, 425815.5801430951, 427418.0, 34179.14552136217, 34748.65251347555, 34989.825050874584, 35079.12302192466, 35096.64903351036, 44299.778501107285, 44309.89225269394, 45005.0, 45261.77369113265, 45808.08383832238, 30394.936177233692, 30407.695923040486, 30440.086797396114, 31373.21566960753, 31598.684013159575, 30151.29575073633, 31366.0, 31394.372112558078, 31474.527882082246, 31540.684593153775, 30726.692733072385, 35871.82064089663, 37421.43867842039, 37442.68950586826, 37517.81241093777, 27690.861545692143, 30110.397792043597, 30941.0, 31255.06234812959, 31434.84282578664, 22741.204057857896, 22832.880299993627, 24181.758182418653, 24655.0, 24684.753152468245], "value": 19371.920768734115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.9805509724513, 433.71374892570907, 434.4135417186798, 442.0716495359744, 449.75713114917926, 16154.273057712402, 21855.235066772668, 23438.531229375403, 24203.273901782974, 24334.51330973382, 23861.284161475185, 24214.0, 24353.87823060882, 24702.011919523244, 24821.0, 6774.390304872561, 6821.24966253713, 6951.860962780741, 7034.331738484836, 7041.260667629902, 4385.0, 4590.288505281686, 4645.628349732014, 6853.17761868574, 6978.057962175092, 7839.960800195991, 7860.213978602123, 7971.362291016705, 7979.444008418361, 8001.759947201594, 7150.356467917886, 7462.626868656545, 7602.42981776369, 7607.0, 7971.880421793649, 6601.7359305627715, 7001.509894307401, 7260.41916646667, 7362.0, 7608.695652173907, 27490.0378486752, 27641.0, 27790.444191116265, 27890.0, 27891.860540697166, 2931.2232258451527, 3022.6523949745842, 3037.6506701729363, 3114.205877501245, 3115.0966219796233, 14770.630734231623, 14815.0, 14969.550913472613, 15261.313240904186, 15474.45839395627, 2028.8275496582808, 2098.3914664747203, 2207.249535158038, 2243.719535058118, 2244.876531790751, 163927.1803640986, 165804.17097914554, 169105.46341804758, 175160.12419937947, 179843.0, 15301.693966120616, 20080.799192008184, 20585.176592936416, 20768.376948691563, 20978.0, 30467.390652187274, 30884.382312353628, 30913.381732365226, 30930.69069309278, 31132.221694457367, 10471.581136754598, 10895.455227238765, 11020.338779673246, 11026.614068507724, 11210.495527701272, 9174.357794954289, 9223.21602663781, 9224.631014759334, 9325.626974920928, 9361.4383137012, 9256.490893000815, 9555.856662150074, 9625.614975401046, 9646.372985756043, 9660.17888479473, 3997.2605068062503, 4016.819243134066, 4023.6177563131455, 4028.8388464461095, 4033.7697002413956, 1064.7444613292755, 1065.8934106589434, 1074.2641290715885, 1076.2036093290908, 1108.4125413530842, 22278.665820012713, 22594.98322575488, 22681.432964176027, 22811.429714256945, 22947.196848110238, 1050.9369437833755, 1054.7415883108688, 1072.1797824664138, 1076.553230409387, 1078.9298695584762, 9334.486603236886, 10798.082163016075, 10858.619948301772, 11536.0, 11580.76838463226, 713653.0, 737560.0, 766919.0, 785524.0, 785702.0, 159943.20028399784, 161025.0, 163922.0, 164640.0, 165575.0, 1190.2798806721983, 1239.151181440716, 1285.1582213650074, 1295.7732396830706, 1296.5850927703045, 19652.0173991297, 19825.30611428593, 20223.0, 20241.493962651053, 20248.797512024692, 45143.77428112838, 52619.473805261456, 66350.33649663634, 66760.66619666871, 66821.33178668345, 64042.67978660077, 88067.55966220128, 89519.0, 90767.5461622714, 91475.54262228646, 7591.58246296459, 9327.580258888502, 9883.072800803775, 11106.666799996014, 11700.941495292469, 11383.54465821358, 12207.267563946192, 12527.185732927695, 12546.1844980076, 12967.22196668203, 10889.836652450062, 11066.889331106586, 11242.437878105899, 11341.716457088638, 11425.257358271685, 10297.12474439681, 10418.791624167627, 10652.467376630982, 10655.946720266658, 10757.731056723644, 11075.335479871233, 11242.044426223863, 11404.885951140383, 11604.245724027911, 11651.475683594428, 8465.95767021161, 9108.134727200906, 9931.453770042717, 11427.885721142682, 11511.712207194887, 10808.135349172204, 10904.945475272572, 11118.833217501582, 11213.495392707511, 11306.547738090385], "value": 11758.40621413636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.6438119232569, 1581.1303782919392, 1602.0, 1614.2816446681218, 1614.6851363984022, 10947.616833410822, 11628.244164129326, 11643.417829108543, 11650.708732281697, 11679.941600291986, 11097.4451277436, 11319.886801131986, 11482.770344593124, 11648.359340236304, 11718.707032324197, 2486.3162630276684, 2520.6093055576416, 2522.3441905104714, 2523.356544081266, 2525.356034211283, 2444.6577479152934, 2450.6324051392344, 2489.7759201671847, 2492.9127480538186, 2495.4510007798253, 2453.116877923946, 2454.1778504201116, 2480.516299321633, 2487.017628036924, 2502.074232533965, 2435.3546310227803, 2441.0357908625992, 2461.7415171407015, 2480.516299321624, 2487.8756062196817, 2452.914148004811, 2472.9752702472924, 2473.307473907309, 2482.7144878338863, 2483.962740558893, 11201.719957001058, 11441.771164576745, 11446.94276528612, 11458.369789661565, 11468.541258349656, 5978.312494063195, 6141.324454310023, 6169.136320915076, 6169.629822210682, 6178.351273116303, 3656.762310449812, 3739.2708421857747, 3800.410936304877, 3831.59768224338, 3833.195029043904, 1271.0975207602614, 1911.4647898588416, 1927.5855691026497, 1985.1265443204943, 1987.3739771971782, 13501.662458438519, 14097.436102555885, 14368.425262989467, 14678.706425871529, 16144.434944776876, 4142.482189726285, 4742.976285118552, 4921.630877684188, 4930.778114984834, 4955.281484184773, 12257.26456412618, 12284.508619655113, 12291.877081229073, 12308.753824923451, 12311.261324320569, 5104.489551044866, 5259.605529585297, 5823.126531020381, 5982.850428739229, 6059.787907423219, 5471.781128754806, 5532.861678458071, 5566.165075238666, 5589.80435684749, 5592.916106258409, 3960.683145348365, 4002.419649150857, 4085.85699500522, 4089.7137200396282, 4089.754614723126, 1050.558765318568, 1064.6593090211059, 1076.6554702495282, 1080.184460732158, 1085.6417382263835, 799.6601444386113, 819.2503858968977, 837.6314421654453, 850.2772643253186, 867.9794315781118, 6261.624302541771, 6743.35938085881, 6754.088198093293, 6765.661716914135, 6766.763163289262, 970.4613939263635, 976.3897564022486, 1003.3177439341172, 1003.6938733686296, 1016.9474593795534, 4232.0, 4278.358246263023, 4288.206681763883, 4317.762523061262, 4375.803088861009, 13791.10357826738, 14431.35058922351, 14458.0, 14471.78292325616, 14563.126212427289, 13094.738105237842, 14325.212113333866, 14345.713085738227, 14364.784528232085, 14380.35288412024, 10136.239782016379, 10388.428636424918, 10433.686989390331, 10436.530356133992, 10440.791184176274, 6789.913613821765, 6867.656617169022, 6993.755218567326, 6999.965000174967, 7062.117235345582, 12666.87333126657, 12933.870661293267, 12961.96304295673, 12963.092583519441, 13105.2136871788, 11513.30920144794, 11657.125715571197, 12767.297798621164, 12958.481660733842, 13072.411741471466, 9250.95374523123, 9515.333926625346, 9521.714348569554, 9529.666461673809, 9566.426014439156, 10137.341072830242, 10520.10579100785, 10577.894221057999, 10665.253432259668, 10679.57281708723, 8733.781655458664, 8881.333899957659, 9019.684311049083, 9044.954775226082, 9178.67874624385, 8779.341549383695, 8798.340124490816, 8839.381243312906, 8847.955760221415, 8901.955490222508, 8077.31342835842, 8228.382871284557, 8260.050094238999, 8261.710840120568, 8283.420160588701, 5032.7483625819295, 5198.194279886624, 5931.0, 6173.98129308677, 6205.689715514297, 5104.9489505104475, 5871.295444546511, 5974.133750606225, 6230.626162430269, 6452.612378501137], "value": 5316.495475818706, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.09858480686944, 371.1871002504513, 390.2760379496035, 391.5946994860319, 399.79210810378584, 4836.685615434999, 4944.6018680939715, 5067.189249720045, 5100.897982040362, 5124.437046700755, 4411.735295882249, 4427.247367947449, 4783.545563171502, 4798.712077275357, 4816.412960965272, 3357.5970883493956, 3859.8070096495203, 4103.79481025949, 4346.413234213388, 4363.825446982117, 3741.850325986957, 3860.4595356650093, 4308.46144231971, 4399.516053234158, 4401.723500184942, 3921.450996860442, 4052.5815964412513, 4382.539833317488, 4412.404325416076, 4443.755593442359, 3966.226585815767, 4208.684348673831, 4235.882058970499, 4353.692542952241, 4360.345948107777, 3496.965030349689, 3503.5970863350785, 3765.7552259103345, 4159.646430053449, 4179.498460184767, 4272.5432876096365, 4501.2670122003265, 4901.137567724242, 4910.263460480921, 4936.728479933602, 4465.084657645175, 4896.534829191221, 5019.548240658358, 5060.84817455477, 5061.443970794762, 4669.953300466986, 5097.643164978453, 5360.410354860962, 5385.515303622654, 5407.513323800877, 4170.874873753762, 4394.516603173648, 4563.018950925533, 4733.621310295202, 4747.311639812242, 4413.713108647928, 4738.038725796378, 4888.557875426758, 5520.503154716095, 5643.633163844337, 4099.8975025624, 4277.529471758104, 4837.830675926326, 4838.419389673191, 4927.310176575283, 4894.510548945077, 4910.337104490919, 4922.547848384664, 4962.702237865739, 4970.700344202239, 4682.531746825291, 4917.286993385939, 5017.774200161001, 5030.84907452777, 5094.6943183408375, 4629.444466663955, 4848.7090774553635, 5207.630528109701, 5314.627976041717, 5392.703401312965, 1543.4829332173622, 1657.1382880901863, 1667.6748034133227, 1678.3370568625326, 1680.1179380825165, 1136.7114863599245, 1192.9522819087313, 1288.904431233463, 1369.9246541440118, 1385.7990591364196, 4473.510661683892, 4479.804895601197, 4595.241785105487, 4997.0, 5036.597072234213, 4458.767393639585, 4874.707517548887, 4892.951070489321, 4955.688550960687, 5173.0, 4267.564610488586, 4737.28940658904, 4873.244647079709, 5073.797048118107, 5135.897282054413, 2586.405126820804, 2731.2625591090296, 2767.6678798544303, 2786.651668541432, 2825.5620378841313, 5101.387833460009, 5363.846772943836, 5637.3235211774845, 5644.350899646511, 5711.514521265739, 4587.632989360844, 5272.657277276965, 5358.892822143535, 5497.615166938276, 5649.406812284733, 5037.3955125384455, 5403.351597808288, 5553.307050811165, 5621.297337832771, 5683.8863222736145, 4919.0, 5298.403782146797, 5335.893282134413, 5376.435474275301, 5435.619506634498, 4380.540043295408, 4588.954110458986, 4926.581240594446, 5261.631685781958, 5434.429384914685, 5121.948780512147, 5586.581006424616, 5602.1512900741845, 5638.23883775685, 5644.983902897354, 4114.629683328395, 4358.607725304738, 4447.865794222453, 4743.83396581118, 4844.878878028077, 4839.782209800497, 5112.401919897706, 5165.236598419828, 5488.0, 5591.329040515164, 4612.354270402079, 4933.753312334441, 5408.486193811582, 5418.972905135449, 5434.375046869661, 4584.495705472462, 4976.601871850171, 5119.030962041932, 5142.254373115802, 5441.680574849418, 4367.213901497761, 4461.556900581286, 4527.5019747827055, 4768.57082862544, 4998.2502624606595, 4631.698939568917, 4959.504049595012, 5403.0, 5414.593905457028, 5443.346798384219, 4676.3686902267755, 4859.9757001216185, 5208.427073021889, 5270.23581580661, 5318.282031925641], "value": 4142.793143848414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.7962129846238, 788.2826627768732, 851.876477910703, 884.2307192742313, 914.0174312613942, 16553.089580073105, 17126.886752361086, 17158.39945601904, 17250.87869288497, 17325.133743312832, 12489.750204995895, 15962.441314553993, 16209.027458352508, 16211.51365459038, 16237.756433653505, 999.0708640963901, 1040.1678657074349, 1046.2101113659176, 1048.52292207046, 1052.8681667207782, 971.8882328532238, 972.1105188752283, 973.0998826085843, 973.459729849933, 976.8095221431823, 1084.7884662490817, 1089.1341383600056, 1089.8528698625664, 1091.6943255888364, 1094.4363652718855, 1083.4853444613825, 1085.6417382263835, 1085.9239853210279, 1086.0605576176629, 1087.1574529739437, 799.5842162075746, 800.3117319105564, 800.3877034068884, 801.3709238247948, 804.7867315161487, 17511.299548018193, 17652.646947061115, 17697.469075927613, 17699.29202831898, 17750.20124094419, 15329.923350383287, 15574.925206708285, 15698.215089245492, 16500.504984850475, 16565.751513727304, 10964.451777411097, 11914.463849126723, 12032.39838008096, 12166.619405101284, 12660.240385576895, 3800.410936304877, 3902.0830104925603, 3937.9212415751526, 4024.8993775155855, 4168.583141685807, 101537.99999999926, 106527.46736266346, 106597.0, 107257.46371268171, 108871.0, 9976.401415915068, 11395.487203075716, 11736.119791015708, 12204.450799714034, 12416.00671946242, 25877.353066173495, 25905.481890362087, 25955.870220648776, 25963.350916227246, 25976.74023259781, 8222.17778222173, 8374.330053595697, 8408.663653453794, 8575.485470871643, 8597.0, 4240.745555266694, 4486.955130448654, 4567.36056952027, 4650.837220697259, 4783.210770222944, 3386.5428167197115, 3438.535797667333, 3443.070370999816, 3449.7585169037925, 3470.583529976419, 606.0, 608.1334098909125, 617.163743128055, 621.170737066022, 627.3506920337429, 697.7592730507967, 713.9000539924415, 722.9349358557755, 761.8438220164853, 787.8463699578642, 8926.776830579287, 10602.628907988337, 10785.245032847783, 11024.50389732464, 11366.545338186545, 708.19619731605, 712.6472396163932, 726.7129483853848, 732.9560226386434, 735.63586024918, 5071.290019397287, 5251.238570407269, 5268.92096618551, 5270.631055826056, 5445.918311225335, 100480.49759751154, 108848.0, 109457.0, 110230.0, 117629.23556146664, 98158.5092074535, 98202.52696209562, 98430.0, 99133.0, 101608.98391015995, 83297.3340533186, 83422.74865877017, 83553.32893342098, 84820.72768908595, 84822.0, 10905.56377744913, 11262.831057534308, 11367.790262172284, 11440.370779606868, 11478.88521114778, 46410.53589464062, 53341.0, 53684.73157634187, 54915.0, 55681.0, 70364.0, 73497.53004939978, 73819.63090184514, 74333.628331858, 76285.23714763003, 13260.602181934557, 13340.19958802475, 13417.530386436429, 13552.390142443812, 14222.928885355506, 15170.469033583771, 15398.230088495306, 15422.305996230421, 15764.132972686153, 16511.09188994617, 13935.30323483842, 14046.076708208966, 14524.709505810037, 14868.40526378976, 14924.179170145311, 11689.473973671034, 14415.927920360331, 14573.562793116223, 14599.343029563908, 15094.39622415091, 12411.379431028594, 13540.93229533846, 13956.79064814049, 14049.929750351592, 14216.928915355356, 10120.696379108638, 10771.0, 10828.404437755999, 10867.402292873652, 11384.772304554028, 9217.124373184537, 10440.895591044296, 10679.626213082505, 11464.656060318204, 11671.88328116708], "value": 8135.50129987911, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 115.0, 114.0, 130.0, 167.0, 170.0, 114.0, 115.0], "value": 127.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 108.0, 142.0, 109.0, 108.0, 108.0, 107.0, 128.0, 106.0], "value": 116.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 186.0, 184.0, 186.0, 192.0, 225.0, 186.0, 186.0], "value": 189.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 61.0, 90.0, 60.0, 59.0, 60.0, 59.0, 73.0, 74.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 84.0, 69.0, 69.0, 68.0, 83.0, 69.0, 68.0, 84.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 90.0, 87.0, 87.0, 88.0, 87.0, 88.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 91.0, 94.0, 93.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 96.0, 128.0, 130.0, 86.0, 86.0, 83.0, 83.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 59.0, 60.0, 61.0, 64.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 66.0, 68.0, 62.0, 59.0, 56.0, 57.0, 58.0, 57.0, 57.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 98.0, 82.0, 83.0, 82.0, 83.0, 83.0, 88.0, 87.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 142.0, 135.0, 134.0, 133.0, 133.0, 151.0, 195.0, 131.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 161.0, 172.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 63.0, 63.0, 63.0, 63.0, 61.0, 61.0], "value": 63.1, "unit": "score"}]}]} 10:26:29 INFO - Return code: 0 10:26:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:29 INFO - # TBPL SUCCESS # 10:26:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:26:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:26:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:26:29 INFO - 2017-04-21 10:26:29.377 screenresolution[1658:9865] starting screenresolution argv=screenresolution get 10:26:29 INFO - 2017-04-21 10:26:29.380 screenresolution[1658:9865] Display 0: 1600x1200x32@60 10:26:29 INFO - 2017-04-21 10:26:29.386 screenresolution[1659:9868] starting screenresolution argv=screenresolution list 10:26:29 INFO - Available Modes on Display 0 10:26:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:26:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:26:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:26:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:26:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:26:29 INFO - Intel Iris: 10:26:29 INFO - Chipset Model: Intel Iris 10:26:29 INFO - Type: GPU 10:26:29 INFO - Bus: Built-In 10:26:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:26:29 INFO - Vendor: Intel (0x8086) 10:26:29 INFO - Device ID: 0x0a2e 10:26:29 INFO - Revision ID: 0x0009 10:26:29 INFO - Displays: 10:26:29 INFO - Display: 10:26:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:26:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:26:29 INFO - Display Serial Number: 1600x1200 60 10:26:29 INFO - Main Display: Yes 10:26:29 INFO - Mirror: Off 10:26:29 INFO - Online: Yes 10:26:29 INFO - Rotation: Supported 10:26:29 INFO - Return code: 0 10:26:29 INFO - Running post-action listener: _resource_record_post_action 10:26:29 INFO - [mozharness: 2017-04-21 17:26:29.632058Z] Finished run-tests step (success) 10:26:29 INFO - Running post-run listener: _resource_record_post_run 10:26:29 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 37000192; Write bytes: 421059584; Read time: 382; Write time: 1399 10:26:29 INFO - TinderboxPrint: CPU usage
53.9% 10:26:29 INFO - TinderboxPrint: I/O read bytes / time
37,000,192 / 382 10:26:29 INFO - TinderboxPrint: I/O write bytes / time
421,059,584 / 1,399 10:26:29 INFO - TinderboxPrint: CPU idle
2,200.3 (46.1%) 10:26:29 INFO - TinderboxPrint: CPU system
952.3 (19.9%) 10:26:29 INFO - TinderboxPrint: CPU user
1,621.1 (34.0%) 10:26:29 INFO - TinderboxPrint: Swap in / out
158,838,784 / 0 10:26:29 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121666048; Write bytes: 115005440; Read time: 11097; Write time: 253 10:26:29 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34386944; Write bytes: 295908352; Read time: 354; Write time: 1117 10:26:30 INFO - Running post-run listener: _upload_blobber_files 10:26:30 INFO - Blob upload gear active. 10:26:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:30 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 10:26:30 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'] 10:26:30 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 10:26:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:31 INFO - (blobuploader) - INFO - Done attempting. 10:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:32 INFO - (blobuploader) - INFO - Done attempting. 10:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:34 INFO - (blobuploader) - INFO - Done attempting. 10:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:36 INFO - (blobuploader) - INFO - Done attempting. 10:26:36 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:36 INFO - Return code: 0 10:26:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da27bca8cc9c8be0c3d2955ac8d1d02a97e5047d4dbf546734e26a1ffaf865ac3581f5999b060bed85c6c2ca54e06fce610eef6bbb3b9872ca1939eb837eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33a40f241b96bfe65706ea9c55e47c84c46a1e8451203897dca0e9bda3803405175d0229d6338975d6853036e5d6cf8fba383768ccf5d2788fc8c0c9feeeba37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fb114b487c0f5c47426e0a918c7072ab6bc12473672a9c7e3c731bc76cbb1868eba0743513f8ce8a7a087f31f5d433c14d91fb976da9af7a3e64d6febf66d5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f809cffb1403aa3b74bd636945cefd8c2dd9c2d0f84f3e8ca5f97cbc5d0313aaef1f8f496776044381d9c0594131c8b863f8b8457e87dd3a71b1ccd274be134d"} 10:26:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:36 INFO - Contents: 10:26:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da27bca8cc9c8be0c3d2955ac8d1d02a97e5047d4dbf546734e26a1ffaf865ac3581f5999b060bed85c6c2ca54e06fce610eef6bbb3b9872ca1939eb837eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33a40f241b96bfe65706ea9c55e47c84c46a1e8451203897dca0e9bda3803405175d0229d6338975d6853036e5d6cf8fba383768ccf5d2788fc8c0c9feeeba37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fb114b487c0f5c47426e0a918c7072ab6bc12473672a9c7e3c731bc76cbb1868eba0743513f8ce8a7a087f31f5d433c14d91fb976da9af7a3e64d6febf66d5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f809cffb1403aa3b74bd636945cefd8c2dd9c2d0f84f3e8ca5f97cbc5d0313aaef1f8f496776044381d9c0594131c8b863f8b8457e87dd3a71b1ccd274be134d"} 10:26:36 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:36 INFO - Copying logs to upload dir... 10:26:36 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.174030 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-21 10:26:37.029630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:26:37.033367) ========= 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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners TMPDIR=/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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/03da27bca8cc9c8be0c3d2955ac8d1d02a97e5047d4dbf546734e26a1ffaf865ac3581f5999b060bed85c6c2ca54e06fce610eef6bbb3b9872ca1939eb837eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33a40f241b96bfe65706ea9c55e47c84c46a1e8451203897dca0e9bda3803405175d0229d6338975d6853036e5d6cf8fba383768ccf5d2788fc8c0c9feeeba37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fb114b487c0f5c47426e0a918c7072ab6bc12473672a9c7e3c731bc76cbb1868eba0743513f8ce8a7a087f31f5d433c14d91fb976da9af7a3e64d6febf66d5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f809cffb1403aa3b74bd636945cefd8c2dd9c2d0f84f3e8ca5f97cbc5d0313aaef1f8f496776044381d9c0594131c8b863f8b8457e87dd3a71b1ccd274be134d"} build_url:https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/C8O2hk18SMaHf6rNIsrFaQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03da27bca8cc9c8be0c3d2955ac8d1d02a97e5047d4dbf546734e26a1ffaf865ac3581f5999b060bed85c6c2ca54e06fce610eef6bbb3b9872ca1939eb837eb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33a40f241b96bfe65706ea9c55e47c84c46a1e8451203897dca0e9bda3803405175d0229d6338975d6853036e5d6cf8fba383768ccf5d2788fc8c0c9feeeba37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fb114b487c0f5c47426e0a918c7072ab6bc12473672a9c7e3c731bc76cbb1868eba0743513f8ce8a7a087f31f5d433c14d91fb976da9af7a3e64d6febf66d5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f809cffb1403aa3b74bd636945cefd8c2dd9c2d0f84f3e8ca5f97cbc5d0313aaef1f8f496776044381d9c0594131c8b863f8b8457e87dd3a71b1ccd274be134d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:26:37.069113) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:26:37.069462) ========= 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.OG6dIzYM7j/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.2uhdNE4fHb/Listeners TMPDIR=/var/folders/gp/d7vysk_107bd1f_88prwsqy800000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:26:37.117896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:26:37.118233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:26:37.118560) ========= ========= Total master_lag: 0.18 =========