builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0392 starttime: 1491517930.74 results: success (0) buildid: 20170406141133 builduid: afd26bbf156d4a9d8c5fd4186dc9170d revision: 65eb65fb5933f1897ca5c572cdf02ac814097ca1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.738871) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.739345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.739667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.766225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.766557) ========= 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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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-06 15:32:10-- 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% 184M=0s 2017-04-06 15:32:10 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.888063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.888417) ========= 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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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.027435 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:10.937281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-06 15:32:10.937638) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 65eb65fb5933f1897ca5c572cdf02ac814097ca1 --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 65eb65fb5933f1897ca5c572cdf02ac814097ca1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uMbyOF8CYO/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.5fE0JJFWfW/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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-06 15:32:11,040 truncating revision to first 12 chars 2017-04-06 15:32:11,040 Setting DEBUG logging. 2017-04-06 15:32:11,040 attempt 1/10 2017-04-06 15:32:11,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/65eb65fb5933?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 15:32:12,977 unpacking tar archive at: mozilla-beta-65eb65fb5933/testing/mozharness/ program finished with exit code 0 elapsedTime=2.213730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-06 15:32:13.175327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:13.175699) ========= script_repo_revision: 65eb65fb5933f1897ca5c572cdf02ac814097ca1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:13.176157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:13.176505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 15:32:13.196412) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-06 15:32:13.196723) ========= /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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:32:13 INFO - MultiFileLogger online at 20170406 15:32:13 in /builds/slave/test 15:32:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:32:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:32:13 INFO - {'append_to_log': False, 15:32:13 INFO - 'base_work_dir': '/builds/slave/test', 15:32:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:32:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:32:13 INFO - 'branch': 'Mozilla-Beta', 15:32:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:32:13 INFO - 'config_files': ('talos/mac_config.py',), 15:32:13 INFO - 'default_actions': ('clobber', 15:32:13 INFO - 'read-buildbot-config', 15:32:13 INFO - 'download-and-extract', 15:32:13 INFO - 'populate-webroot', 15:32:13 INFO - 'create-virtualenv', 15:32:13 INFO - 'install', 15:32:13 INFO - 'run-tests'), 15:32:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:32:13 INFO - 'download_minidump_stackwalk': True, 15:32:13 INFO - 'download_symbols': 'ondemand', 15:32:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:32:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:32:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:32:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:32:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:32:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:32:13 INFO - 'installer_path': 'installer.exe', 15:32:13 INFO - 'log_level': 'info', 15:32:13 INFO - 'log_name': 'talos', 15:32:13 INFO - 'log_to_console': True, 15:32:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:32:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:32:13 INFO - 'opt_config_files': (), 15:32:13 INFO - 'pip_index': False, 15:32:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:13 INFO - 'cmd': ('bash', 15:32:13 INFO - '-c', 15:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:13 INFO - 'enabled': True, 15:32:13 INFO - 'halt_on_failure': False, 15:32:13 INFO - 'name': 'check_screen_resolution'},), 15:32:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:32:13 INFO - 'cmd': ('bash', 15:32:13 INFO - '-c', 15:32:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:32:13 INFO - 'enabled': True, 15:32:13 INFO - 'halt_on_failure': False, 15:32:13 INFO - 'name': 'check_screen_resolution'},), 15:32:13 INFO - 'run_cmd_checks_enabled': True, 15:32:13 INFO - 'sps_profile': False, 15:32:13 INFO - 'sps_profile_interval': 0, 15:32:13 INFO - 'suite': 'dromaeojs', 15:32:13 INFO - 'system_bits': '32', 15:32:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:32:13 INFO - 'title': 't-yosemite-r7-0392', 15:32:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:32:13 INFO - 'use_talos_json': True, 15:32:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:32:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:32:13 INFO - 'work_dir': 'build'} 15:32:13 INFO - [mozharness: 2017-04-06 22:32:13.406280Z] Running clobber step. 15:32:13 INFO - Running pre-action listener: _resource_record_pre_action 15:32:13 INFO - Running main action method: clobber 15:32:13 INFO - rmtree: /builds/slave/test/build 15:32:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:32:15 INFO - Running post-action listener: _resource_record_post_action 15:32:15 INFO - [mozharness: 2017-04-06 22:32:15.834072Z] Finished clobber step (success) 15:32:15 INFO - [mozharness: 2017-04-06 22:32:15.834239Z] Running read-buildbot-config step. 15:32:15 INFO - Running pre-action listener: _resource_record_pre_action 15:32:15 INFO - Running main action method: read_buildbot_config 15:32:15 INFO - Using buildbot properties: 15:32:15 INFO - { 15:32:15 INFO - "project": "", 15:32:15 INFO - "product": "firefox", 15:32:15 INFO - "script_repo_revision": "production", 15:32:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:32:15 INFO - "repository": "", 15:32:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:32:15 INFO - "buildid": "20170406141133", 15:32:15 INFO - "pgo_build": "False", 15:32:15 INFO - "basedir": "/builds/slave/test", 15:32:15 INFO - "buildnumber": 8, 15:32:15 INFO - "slavename": "t-yosemite-r7-0392", 15:32:15 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:32:15 INFO - "platform": "yosemite_r7", 15:32:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:32:15 INFO - "branch": "mozilla-beta", 15:32:15 INFO - "repo_path": "releases/mozilla-beta", 15:32:15 INFO - "revision": "65eb65fb5933f1897ca5c572cdf02ac814097ca1", 15:32:15 INFO - "stage_platform": "macosx64", 15:32:15 INFO - "builduid": "afd26bbf156d4a9d8c5fd4186dc9170d", 15:32:15 INFO - "slavebuilddir": "test" 15:32:15 INFO - } 15:32:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:32:15 INFO - Running post-action listener: _resource_record_post_action 15:32:15 INFO - [mozharness: 2017-04-06 22:32:15.837388Z] Finished read-buildbot-config step (success) 15:32:15 INFO - [mozharness: 2017-04-06 22:32:15.837518Z] Running download-and-extract step. 15:32:15 INFO - Running pre-action listener: _resource_record_pre_action 15:32:15 INFO - Running main action method: download_and_extract 15:32:15 INFO - mkdir: /builds/slave/test/build/tests 15:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:15 INFO - trying https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:32:15 INFO - Downloading https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:32:16 INFO - Downloaded 1165 bytes. 15:32:16 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:32:16 INFO - Using the following test package requirements: 15:32:16 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:32:16 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:32:16 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:32:16 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:32:16 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:32:16 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:32:16 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:32:16 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:32:16 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:32:16 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:32:16 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:32:16 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:32:17 INFO - Expected file size: 16116416 15:32:17 INFO - Obtained file size: 16116416 15:32:24 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:32:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:32:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:32:24 INFO - Fetch https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:32:25 INFO - Expected file size: 16116416 15:32:25 INFO - Obtained file size: 16116416 15:32:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:32:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:32:31 INFO - Fetch https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:32:32 INFO - Expected file size: 14403650 15:32:32 INFO - Obtained file size: 14403650 15:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:32 INFO - trying https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:32:32 INFO - Downloading https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:32:34 INFO - Downloaded 58736990 bytes. 15:32:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:32:34 INFO - mkdir: /builds/slave/test/properties 15:32:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:34 INFO - Contents: 15:32:34 INFO - build_url:https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:32:35 INFO - Running post-action listener: _resource_record_post_action 15:32:35 INFO - Running post-action listener: set_extra_try_arguments 15:32:35 INFO - [mozharness: 2017-04-06 22:32:35.197566Z] Finished download-and-extract step (success) 15:32:35 INFO - [mozharness: 2017-04-06 22:32:35.197693Z] Running populate-webroot step. 15:32:35 INFO - Running pre-action listener: _resource_record_pre_action 15:32:35 INFO - Running main action method: populate_webroot 15:32:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:35 INFO - '--tppagecycles', 15:32:35 INFO - '7'], 15:32:35 INFO - 'tests': ['tsvgm']}}, 15:32:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['damp', 'tps']}, 15:32:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'tests': ['damp', 'tps']}, 15:32:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['dromaeo_dom']}, 15:32:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['basic_compositor_video']}, 15:32:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:32:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['a11yr', 15:32:35 INFO - 'ts_paint', 15:32:35 INFO - 'tpaint', 15:32:35 INFO - 'sessionrestore', 15:32:35 INFO - 'sessionrestore_no_auto_restore', 15:32:35 INFO - 'tabpaint']}, 15:32:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:35 INFO - 'ts_paint', 15:32:35 INFO - 'tpaint', 15:32:35 INFO - 'sessionrestore', 15:32:35 INFO - 'sessionrestore_no_auto_restore', 15:32:35 INFO - 'tabpaint']}, 15:32:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:35 INFO - 'ts_paint', 15:32:35 INFO - 'tpaint', 15:32:35 INFO - 'sessionrestore', 15:32:35 INFO - 'sessionrestore_no_auto_restore', 15:32:35 INFO - 'tabpaint']}, 15:32:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:35 INFO - 'ts_paint', 15:32:35 INFO - 'tpaint', 15:32:35 INFO - 'sessionrestore', 15:32:35 INFO - 'sessionrestore_no_auto_restore', 15:32:35 INFO - 'tabpaint']}, 15:32:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['a11yr', 15:32:35 INFO - 'ts_paint', 15:32:35 INFO - 'tpaint', 15:32:35 INFO - 'sessionrestore', 15:32:35 INFO - 'sessionrestore_no_auto_restore', 15:32:35 INFO - 'tabpaint']}, 15:32:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['a11yr', 15:32:35 INFO - 'ts_paint', 15:32:35 INFO - 'tpaint', 15:32:35 INFO - 'sessionrestore', 15:32:35 INFO - 'sessionrestore_no_auto_restore', 15:32:35 INFO - 'tabpaint']}, 15:32:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['tsvgx', 15:32:35 INFO - 'tsvgr_opacity', 15:32:35 INFO - 'tart', 15:32:35 INFO - 'tscrollx', 15:32:35 INFO - 'cart', 15:32:35 INFO - 'tsvg_static']}, 15:32:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:35 INFO - 'tsvgr_opacity', 15:32:35 INFO - 'tart', 15:32:35 INFO - 'tscrollx', 15:32:35 INFO - 'cart', 15:32:35 INFO - 'tsvg_static']}, 15:32:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'talos_options': ['--disable-e10s'], 15:32:35 INFO - 'tests': ['tp5o']}, 15:32:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:32:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'talos_options': ['--disable-e10s', 15:32:35 INFO - '--xperf_path', 15:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:35 INFO - 'tests': ['tp5n']}, 15:32:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:32:35 INFO - 'talos_options': ['--xperf_path', 15:32:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:35 INFO - 'tests': ['tp5n']}}, 15:32:35 INFO - 'talos.zip': {'path': '', 15:32:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:35 INFO - Running post-action listener: _resource_record_post_action 15:32:35 INFO - [mozharness: 2017-04-06 22:32:35.217034Z] Finished populate-webroot step (success) 15:32:35 INFO - [mozharness: 2017-04-06 22:32:35.217148Z] Running create-virtualenv step. 15:32:35 INFO - Running pre-action listener: _resource_record_pre_action 15:32:35 INFO - Running main action method: create_virtualenv 15:32:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:32:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:35 INFO - Using real prefix '/tools/python27' 15:32:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:39 INFO - Installing pip.................done. 15:32:39 INFO - Return code: 0 15:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:32:39 INFO - Reading from file tmpfile_stdout 15:32:39 INFO - Output received: 15:32:39 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) 15:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:39 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:39 INFO - 'HOME': '/Users/cltbld', 15:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:39 INFO - 'LOGNAME': 'cltbld', 15:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:39 INFO - 'MOZ_NO_REMOTE': '1', 15:32:39 INFO - 'NO_EM_RESTART': '1', 15:32:39 INFO - 'PAGER': '/bin/cat', 15:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:39 INFO - 'PWD': '/builds/slave/test', 15:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:39 INFO - 'SHELL': '/bin/bash', 15:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:39 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:39 INFO - 'USER': 'cltbld', 15:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:39 INFO - 'XPC_FLAGS': '0x0', 15:32:39 INFO - 'XPC_SERVICE_NAME': '0', 15:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:32:39 INFO - Cleaning up... 15:32:39 INFO - Return code: 0 15:32:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:39 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:39 INFO - 'HOME': '/Users/cltbld', 15:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:39 INFO - 'LOGNAME': 'cltbld', 15:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:39 INFO - 'MOZ_NO_REMOTE': '1', 15:32:39 INFO - 'NO_EM_RESTART': '1', 15:32:39 INFO - 'PAGER': '/bin/cat', 15:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:39 INFO - 'PWD': '/builds/slave/test', 15:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:39 INFO - 'SHELL': '/bin/bash', 15:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:39 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:39 INFO - 'USER': 'cltbld', 15:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:39 INFO - 'XPC_FLAGS': '0x0', 15:32:39 INFO - 'XPC_SERVICE_NAME': '0', 15:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:39 INFO - Downloading/unpacking psutil>=3.1.1 15:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:43 INFO - Installing collected packages: psutil 15:32:43 INFO - Running setup.py install for psutil 15:32:43 INFO - building 'psutil._psutil_osx' extension 15:32:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:32:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:32:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:32:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:32:44 INFO - building 'psutil._psutil_posix' extension 15:32:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:32:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:32:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:32:44 INFO - ^ 15:32:44 INFO - 1 warning generated. 15:32:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:44 INFO - Successfully installed psutil 15:32:44 INFO - Cleaning up... 15:32:44 INFO - Return code: 0 15:32:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:44 INFO - 'HOME': '/Users/cltbld', 15:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:44 INFO - 'LOGNAME': 'cltbld', 15:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:44 INFO - 'MOZ_NO_REMOTE': '1', 15:32:44 INFO - 'NO_EM_RESTART': '1', 15:32:44 INFO - 'PAGER': '/bin/cat', 15:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:44 INFO - 'PWD': '/builds/slave/test', 15:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:44 INFO - 'SHELL': '/bin/bash', 15:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:44 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:44 INFO - 'USER': 'cltbld', 15:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:44 INFO - 'XPC_FLAGS': '0x0', 15:32:44 INFO - 'XPC_SERVICE_NAME': '0', 15:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:47 INFO - Installing collected packages: mozsystemmonitor 15:32:47 INFO - Running setup.py install for mozsystemmonitor 15:32:47 INFO - Successfully installed mozsystemmonitor 15:32:47 INFO - Cleaning up... 15:32:47 INFO - Return code: 0 15:32:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:47 INFO - 'HOME': '/Users/cltbld', 15:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:47 INFO - 'LOGNAME': 'cltbld', 15:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:47 INFO - 'MOZ_NO_REMOTE': '1', 15:32:47 INFO - 'NO_EM_RESTART': '1', 15:32:47 INFO - 'PAGER': '/bin/cat', 15:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:47 INFO - 'PWD': '/builds/slave/test', 15:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:47 INFO - 'SHELL': '/bin/bash', 15:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:47 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:47 INFO - 'USER': 'cltbld', 15:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:47 INFO - 'XPC_FLAGS': '0x0', 15:32:47 INFO - 'XPC_SERVICE_NAME': '0', 15:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:51 INFO - warning: no files found matching '*.txt' 15:32:51 INFO - no previously-included directories found matching 'build' 15:32:51 INFO - no previously-included directories found matching 'dist' 15:32:51 INFO - no previously-included directories found matching '.git*' 15:32:51 INFO - Installing collected packages: jsonschema, functools32 15:32:51 INFO - Running setup.py install for functools32 15:32:51 INFO - warning: no files found matching '*.txt' 15:32:51 INFO - no previously-included directories found matching 'build' 15:32:51 INFO - no previously-included directories found matching 'dist' 15:32:51 INFO - no previously-included directories found matching '.git*' 15:32:51 INFO - Successfully installed jsonschema functools32 15:32:51 INFO - Cleaning up... 15:32:51 INFO - Return code: 0 15:32:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:51 INFO - 'HOME': '/Users/cltbld', 15:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:51 INFO - 'LOGNAME': 'cltbld', 15:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:51 INFO - 'MOZ_NO_REMOTE': '1', 15:32:51 INFO - 'NO_EM_RESTART': '1', 15:32:51 INFO - 'PAGER': '/bin/cat', 15:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:51 INFO - 'PWD': '/builds/slave/test', 15:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:51 INFO - 'SHELL': '/bin/bash', 15:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:51 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:51 INFO - 'USER': 'cltbld', 15:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:51 INFO - 'XPC_FLAGS': '0x0', 15:32:51 INFO - 'XPC_SERVICE_NAME': '0', 15:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:32:51 INFO - Cleaning up... 15:32:51 INFO - Return code: 0 15:32:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:51 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:51 INFO - 'HOME': '/Users/cltbld', 15:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:51 INFO - 'LOGNAME': 'cltbld', 15:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:51 INFO - 'MOZ_NO_REMOTE': '1', 15:32:51 INFO - 'NO_EM_RESTART': '1', 15:32:51 INFO - 'PAGER': '/bin/cat', 15:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:51 INFO - 'PWD': '/builds/slave/test', 15:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:51 INFO - 'SHELL': '/bin/bash', 15:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:51 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:51 INFO - 'USER': 'cltbld', 15:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:51 INFO - 'XPC_FLAGS': '0x0', 15:32:51 INFO - 'XPC_SERVICE_NAME': '0', 15:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:52 INFO - Downloading/unpacking blobuploader==1.2.4 15:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:56 INFO - Downloading docopt-0.6.1.tar.gz 15:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:56 INFO - Running setup.py install for blobuploader 15:32:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:56 INFO - Running setup.py install for requests 15:32:56 INFO - Running setup.py install for docopt 15:32:56 INFO - Successfully installed blobuploader requests docopt 15:32:56 INFO - Cleaning up... 15:32:57 INFO - Return code: 0 15:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:57 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:32:57 INFO - 'HOME': '/Users/cltbld', 15:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:32:57 INFO - 'LOGNAME': 'cltbld', 15:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:57 INFO - 'MOZ_NO_REMOTE': '1', 15:32:57 INFO - 'NO_EM_RESTART': '1', 15:32:57 INFO - 'PAGER': '/bin/cat', 15:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:57 INFO - 'PWD': '/builds/slave/test', 15:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:32:57 INFO - 'SHELL': '/bin/bash', 15:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:32:57 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:32:57 INFO - 'USER': 'cltbld', 15:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:57 INFO - 'XPC_FLAGS': '0x0', 15:32:57 INFO - 'XPC_SERVICE_NAME': '0', 15:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-3Qn0XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-kDyner-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-vRny_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-uT2Lan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-SPxt9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-0uAjHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:57 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Dan4yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-JjXVd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-BSJhH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-dUBX7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-HBzm0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-FKZ3Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-WslzTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Ym67IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-f7xlXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-hSf5K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:58 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-l9nrVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:59 INFO - Running setup.py install for manifestparser 15:32:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozcrash 15:32:59 INFO - Running setup.py install for mozdebug 15:32:59 INFO - Running setup.py install for mozdevice 15:32:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozfile 15:32:59 INFO - Running setup.py install for mozhttpd 15:32:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozinfo 15:33:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Running setup.py install for mozInstall 15:33:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Running setup.py install for mozleak 15:33:00 INFO - Running setup.py install for mozlog 15:33:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Running setup.py install for moznetwork 15:33:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Running setup.py install for mozprocess 15:33:00 INFO - Running setup.py install for mozprofile 15:33:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:33:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:33:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:33:01 INFO - Running setup.py install for mozrunner 15:33:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:33:01 INFO - Running setup.py install for mozscreenshot 15:33:01 INFO - Running setup.py install for moztest 15:33:01 INFO - Running setup.py install for mozversion 15:33:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:01 INFO - Cleaning up... 15:33:01 INFO - Return code: 0 15:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:02 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:02 INFO - 'HOME': '/Users/cltbld', 15:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:02 INFO - 'LOGNAME': 'cltbld', 15:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:02 INFO - 'MOZ_NO_REMOTE': '1', 15:33:02 INFO - 'NO_EM_RESTART': '1', 15:33:02 INFO - 'PAGER': '/bin/cat', 15:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:02 INFO - 'PWD': '/builds/slave/test', 15:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:02 INFO - 'SHELL': '/bin/bash', 15:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:33:02 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:02 INFO - 'USER': 'cltbld', 15:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:02 INFO - 'XPC_FLAGS': '0x0', 15:33:02 INFO - 'XPC_SERVICE_NAME': '0', 15:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:02 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-fkJ3r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:02 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-DcNp2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:02 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)) 15:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:02 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Ai5O7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-1JxJHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:03 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)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-0SnQ_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-hMne53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-DsQjow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-rgyf7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Idj60r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-dZmrRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Dmv9D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:03 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-YVUAzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:04 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-LNRGSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:04 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-NF8wwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:04 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)) 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:04 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-iJ_N0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:04 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-CoYCbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:04 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)) 15:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:04 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-T_u59q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:33:04 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)) 15:33:04 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)) 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:33:04 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)) 15:33:04 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)) 15:33:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:33:07 INFO - Downloading blessings-1.6.tar.gz 15:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:07 INFO - Installing collected packages: blessings 15:33:07 INFO - Running setup.py install for blessings 15:33:07 INFO - Successfully installed blessings 15:33:07 INFO - Cleaning up... 15:33:07 INFO - Return code: 0 15:33:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:08 INFO - Reading from file tmpfile_stdout 15:33:08 INFO - Current package versions: 15:33:08 INFO - blessings == 1.6 15:33:08 INFO - blobuploader == 1.2.4 15:33:08 INFO - docopt == 0.6.1 15:33:08 INFO - functools32 == 3.2.3-2 15:33:08 INFO - jsonschema == 2.5.1 15:33:08 INFO - manifestparser == 1.1 15:33:08 INFO - mozInstall == 1.12 15:33:08 INFO - mozcrash == 1.0 15:33:08 INFO - mozdebug == 0.1 15:33:08 INFO - mozdevice == 0.49 15:33:08 INFO - mozfile == 1.2 15:33:08 INFO - mozhttpd == 0.7 15:33:08 INFO - mozinfo == 0.9 15:33:08 INFO - mozleak == 0.1 15:33:08 INFO - mozlog == 3.4 15:33:08 INFO - moznetwork == 0.27 15:33:08 INFO - mozprocess == 0.24 15:33:08 INFO - mozprofile == 0.28 15:33:08 INFO - mozrunner == 6.13 15:33:08 INFO - mozscreenshot == 0.1 15:33:08 INFO - mozsystemmonitor == 0.3 15:33:08 INFO - moztest == 0.8 15:33:08 INFO - mozversion == 1.4 15:33:08 INFO - psutil == 3.1.1 15:33:08 INFO - requests == 1.2.3 15:33:08 INFO - wsgiref == 0.1.2 15:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:08 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:33:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:33:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:08 INFO - 'HOME': '/Users/cltbld', 15:33:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:08 INFO - 'LOGNAME': 'cltbld', 15:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:08 INFO - 'MOZ_NO_REMOTE': '1', 15:33:08 INFO - 'NO_EM_RESTART': '1', 15:33:08 INFO - 'PAGER': '/bin/cat', 15:33:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:08 INFO - 'PWD': '/builds/slave/test', 15:33:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:08 INFO - 'SHELL': '/bin/bash', 15:33:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:33:08 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:33:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:08 INFO - 'USER': 'cltbld', 15:33:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:08 INFO - 'XPC_FLAGS': '0x0', 15:33:08 INFO - 'XPC_SERVICE_NAME': '0', 15:33:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:33:08 INFO - Cleaning up... 15:33:08 INFO - Return code: 0 15:33:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:08 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 0x1096adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a81479270>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, '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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:33:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:33:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:08 INFO - 'HOME': '/Users/cltbld', 15:33:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:08 INFO - 'LOGNAME': 'cltbld', 15:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:08 INFO - 'MOZ_NO_REMOTE': '1', 15:33:08 INFO - 'NO_EM_RESTART': '1', 15:33:08 INFO - 'PAGER': '/bin/cat', 15:33:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:08 INFO - 'PWD': '/builds/slave/test', 15:33:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:08 INFO - 'SHELL': '/bin/bash', 15:33:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:33:08 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:33:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:08 INFO - 'USER': 'cltbld', 15:33:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:08 INFO - 'XPC_FLAGS': '0x0', 15:33:08 INFO - 'XPC_SERVICE_NAME': '0', 15:33:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:33:08 INFO - Cleaning up... 15:33:08 INFO - Return code: 0 15:33:08 INFO - Running post-action listener: _resource_record_post_action 15:33:08 INFO - Running post-action listener: _start_resource_monitoring 15:33:08 INFO - Starting resource monitoring. 15:33:08 INFO - [mozharness: 2017-04-06 22:33:08.832510Z] Finished create-virtualenv step (success) 15:33:08 INFO - [mozharness: 2017-04-06 22:33:08.833430Z] Running install step. 15:33:08 INFO - Running pre-action listener: _resource_record_pre_action 15:33:08 INFO - Running main action method: install 15:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:09 INFO - Reading from file tmpfile_stdout 15:33:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:09 INFO - Reading from file tmpfile_stdout 15:33:09 INFO - Output received: 15:33:09 INFO - Usage: mozinstall [options] installer 15:33:09 INFO - Options: 15:33:09 INFO - -h, --help show this help message and exit 15:33:09 INFO - -d DEST, --destination=DEST 15:33:09 INFO - Directory to install application into. [default: 15:33:09 INFO - "/builds/slave/test"] 15:33:09 INFO - --app=APP Application being installed. [default: firefox] 15:33:09 INFO - mkdir: /builds/slave/test/build/application 15:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:33:24 INFO - Reading from file tmpfile_stdout 15:33:24 INFO - Output received: 15:33:24 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:33:24 INFO - Running post-action listener: _resource_record_post_action 15:33:24 INFO - [mozharness: 2017-04-06 22:33:24.034571Z] Finished install step (success) 15:33:24 INFO - [mozharness: 2017-04-06 22:33:24.034698Z] Running run-tests step. 15:33:24 INFO - Running pre-action listener: _resource_record_pre_action 15:33:24 INFO - Running main action method: run_tests 15:33:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:33:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:33:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:33:24 INFO - 2017-04-06 15:33:24.049 screenresolution[1628:7230] starting screenresolution argv=screenresolution get 15:33:24 INFO - 2017-04-06 15:33:24.051 screenresolution[1628:7230] Display 0: 1600x1200x32@60 15:33:24 INFO - 2017-04-06 15:33:24.057 screenresolution[1629:7232] starting screenresolution argv=screenresolution list 15:33:24 INFO - Available Modes on Display 0 15:33:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:33:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:33:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:33:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:33:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:33:24 INFO - Intel Iris: 15:33:24 INFO - Chipset Model: Intel Iris 15:33:24 INFO - Type: GPU 15:33:24 INFO - Bus: Built-In 15:33:24 INFO - VRAM (Dynamic, Max): 1536 MB 15:33:24 INFO - Vendor: Intel (0x8086) 15:33:24 INFO - Device ID: 0x0a2e 15:33:24 INFO - Revision ID: 0x0009 15:33:24 INFO - Displays: 15:33:24 INFO - Display: 15:33:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:33:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:33:24 INFO - Display Serial Number: 1600x1200 60 15:33:24 INFO - Main Display: Yes 15:33:24 INFO - Mirror: Off 15:33:24 INFO - Online: Yes 15:33:24 INFO - Rotation: Supported 15:33:24 INFO - Return code: 0 15:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:24 INFO - Python 2.7.3 15:33:24 INFO - Return code: 0 15:33:24 INFO - grabbing minidump binary from tooltool 15:33: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')]} 15:33:24 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 0x10948bd30>, '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 0x1093b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109480be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:33:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:33:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:33:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:24 INFO - Return code: 0 15:33:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:33:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:33:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:24 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/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:33:24 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/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0392 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uMbyOF8CYO/Render', 15:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:33:24 INFO - 'HOME': '/Users/cltbld', 15:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:33:24 INFO - 'LOGNAME': 'cltbld', 15:33:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:24 INFO - 'MOZ_NO_REMOTE': '1', 15:33:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:24 INFO - 'NO_EM_RESTART': '1', 15:33:24 INFO - 'PAGER': '/bin/cat', 15:33:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:24 INFO - 'PWD': '/builds/slave/test', 15:33:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:33:24 INFO - 'SHELL': '/bin/bash', 15:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5fE0JJFWfW/Listeners', 15:33:24 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 15:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:33:24 INFO - 'USER': 'cltbld', 15:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:24 INFO - 'XPC_FLAGS': '0x0', 15:33:24 INFO - 'XPC_SERVICE_NAME': '0', 15:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:33:24 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/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:33:24 INFO - mozversion application_buildid: 20170406141133 15:33:24 INFO - mozversion application_changeset: 65eb65fb5933f1897ca5c572cdf02ac814097ca1 15:33:24 INFO - mozversion application_display_name: Firefox 15:33:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:24 INFO - mozversion application_name: Firefox 15:33:24 INFO - mozversion application_remotingname: firefox 15:33:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:33:24 INFO - mozversion application_vendor: Mozilla 15:33:24 INFO - mozversion application_version: 53.0 15:33:24 INFO - mozversion platform_buildid: 20170406141133 15:33:24 INFO - mozversion platform_changeset: 65eb65fb5933f1897ca5c572cdf02ac814097ca1 15:33:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:33:24 INFO - mozversion platform_version: 53.0 15:33:24 INFO - using testdate: 1491518004 15:33:24 INFO - actual date: 1491518004 15:33:24 INFO - starting webserver on 'localhost:49242' 15:33:24 INFO - SUITE-START | Running 2 tests 15:33:24 INFO - TEST-START | dromaeo_css 15:33:24 INFO - operating with platform_type : mac_ 15:33:24 INFO - Initialising browser for dromaeo_css test... 15:33:24 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpMB1NMv/profile http://localhost:49242/getInfo.html) 15:33:26 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 15:33:26 INFO - PROCESS | 1639 | colorDepth:24 15:33:26 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 15:33:26 INFO - PROCESS | 1639 | __metrics 15:33:26 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:33:26 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:27 INFO - TEST-INFO | 1639: exit 0 15:33:27 INFO - Browser initialized. 15:33:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:27 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpMB1NMv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:39 INFO - PROCESS | 1642 | RSS: Main: 163504128 15:33:39 INFO - PROCESS | 1642 | 15:36:42 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 15:36:44 INFO - PROCESS | 1642 | RSS: Main: 328437760 15:36:44 INFO - PROCESS | 1642 | 15:39:47 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 15:39:47 INFO - PROCESS | 1642 | RSS: Main: 306348032 15:39:47 INFO - PROCESS | 1642 | 15:42:50 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 15:42:50 INFO - PROCESS | 1642 | RSS: Main: 299921408 15:42:50 INFO - PROCESS | 1642 | 15:45:53 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 15:45:53 INFO - PROCESS | 1642 | RSS: Main: 280039424 15:45:53 INFO - PROCESS | 1642 | 15:48:56 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 15:48:57 INFO - PROCESS | 1642 | RSS: Main: 257810432 15:48:57 INFO - PROCESS | 1642 | 15:52:00 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 15:52:01 INFO - PROCESS | 1642 | RSS: Main: 318115840 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | __start_tp_report 15:52:01 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 15:52:01 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 15:52:01 INFO - PROCESS | 1642 | |i|pagename|runs| 15:52:01 INFO - PROCESS | 1642 | |0;dojo.html;3489.2149266415054;3505.754597178197;3522.418800897852;3524.2951409718053;3568.107973006748;5898.764049438023;5908.88182236355;5911.704414779255;5939.020061689821;5966.403359664031;5817.970910145444;5847.239858818359;5853.326867410249;5868.970655146729;5878.206442130311;5156.20078887773;5217.3217481727515;5246.658967167122;5251.291075704769;5272.578193744491;5235.764390602432;5255.369355677324;5264.131418315973;5328.49379308965;5332.200169974515;5292.682439053649;5312.867178320535;5321.122014867542;5336.332958380202;5374.408815030343;5332.226827110087;5339.22581225722;5350.652207606532;5353.197020446925;5373.113436283009;4493.752843593601;5182.689038657655;5207.609429292818;5298.046351656701;5343.625946183769;5759.827205183851;5789.739461724233;5798.9130163047585;5838.065909454509;5843.094320380348;6353.364663533656;6356.872862542723;6377.043443483514;6384.840378990516;6397.616143031387;5285.762140703678;6258.24901011877;6295;6304.905426418607;6322.114903913456;5854.824355269348;5900.616459930091;5937.524998000106;6004.219451471325;6008.2370187177285;6289.7169627366875;6311.431971122529;6314.873702525923;6339.4611458025665;6391.296957334689;6320.178376810985;6322.304546499881;6323.683815809283;6334;6338.524610654219;6296.496280297565;6330.366963303725;6350.7777227796805;6355.9512680407215;6356.586821856565;5217.452167522356;6182.165407669907;6223.751049958041;6279.96860015697;6313.810585682437;6348.682565871688;6352.777652782131;6366.076918846741;6383;6387.169667943231;5054.064997975386;5058.367704036996;5061.6962982221185;5066.214736715741;5092.26162206478;4424.424824772759;4442.20040392726;4481.126180394792;4491.214037543416;4501.3022981437925;5927.585069045212;5971.104334349882;5973.283206015306;5997.070454079625;6016.1878146450545;5684.914726279109;6156.29202641702;6332.873342533124;6353;6368.42684158428;5908.05471124618;5919.408059194132;5946.07835785454;5958.791442299499;5969.701514924236;5549.556035517229;5571.192177134293;5571.247881535941;5578.9163162552595;5608.495235428831;6395.583078415243;6410.134631824737;6413.6793160341795;6423.389777971085;6433.613983161025;6217.316095229611;6283.842903927439;6288.779892703734;6317.147185129948;6317.399847014526;6290.591111577733;6325.525585581007;6338.904916426165;6365.363463653597;6464.644444555594;6345.270293916259;6350.809475715736;6370.076338930921;6372.649504277124;6382.712777924911;6284.717187726472;6307.842303942438;6320.020396838498;6323.399277068671;6335.746570137328;6118.101457354478;6123.4488895999575;6241.625502469867;6258.405451482102;6293.339199383999;6290.24517057956;6322.873542529215;6324.209473815773;6336.904946425715;6362.522810789117;4946.876328091683;6180.598261113013;6188.2883468399905;6199.256089269316;6220.129181914626;6124.3609037543765;6166.414190651881;6204.100405441095;6217.720202590804;6256.280527739368;6160.537959652955;6164.907526387018;6194.752209911553;6196.1015652731;6204.286507051566 15:52:01 INFO - PROCESS | 1642 | |1;ext.html;466.44493053266586;486.9245266983619;498.606101180068;522.2949018824586;544.7439703339429;25549.616755748677;32893.01320960375;32911.177220569465;40618.79690601543;41492.792536037356;42799.14401711964;43194;43267.78366108173;43280.78359608197;43383.34924976128;8590.699325523608;9381.765455863624;9494.715158545254;9701.223902087851;9707.223422126213;8840.33697472689;9040.186383225508;9487.28845336599;9605.519724013771;11684;11506;11732.706682332924;11745.177837551375;11748.647540573797;11783.234089784179;9948.850767238497;11669.941650291694;11778.705532361673;11783.998360139398;11901.58344457944;11599.246049006788;11665.941670291679;11683.182177247596;11685.12361572877;11690.649280521598;40044.19911601781;40367.59632403668;40410.59589404098;40432.98917527085;40439.393409098884;4039.5560685785263;4049.250888585621;4081.285774989365;4117.238310912461;4141.233871733709;29606.25984350387;30072.69927300721;31581.526277105862;31829.204269893205;32117;3264.2329052672603;3316.2372654289406;3480.1821571930577;3512.7189824813954;3515.2090779574646;471641.2835871666;475174.99999999657;477254;477765;477999;62031.68984155141;62133.689331553054;62227.68886155631;62353;62433.06350404747;61787;63474.682626586575;63513.729725406156;63682.68158659177;63816.36183638197;16750.497485075466;17350.739738903925;17427.215775290144;17482.912585437247;17519.912400437915;13268.668283292802;13444.932775336256;13582.049256551947;13606.523771667944;13632.591022269347;11628.069754419626;14383.424663013571;14415.855841441451;14634.341454634567;15872.206389680701;5726.599138060295;6616.305287944792;7832.490888092256;7939.325157361689;7970.9202907970175;640.9839754006188;836.0970152235572;836.8159005018886;843.7806170395742;866.7096522664978;30095;30139.397212056076;30159.849200753855;30392.240193995327;30620.84689576538;861.7587075618836;1076.4348716923678;1131.3268605179906;1139.6751925701135;1230.686175025363;15736;15743.606409839846;15755.291011904492;15768.211589420484;15969.361225550847;629230;635256;635554;635917;636944;56589.43410565924;57565;60383.79232415327;60851.39148608457;61417.69291153605;1447.9131252124905;1476.5865557643876;1492.5074725340394;1492.8208614966275;1494.686115915648;29951.951681691036;31130.688693113683;31143.844280778452;31304.686953130178;31765;50160.49839501558;50701;50914.74542627263;51010;51069;497862;501743;581179;581467;597883;25979.610305845807;26822.865885671228;26903.461930760885;26911;26954.32614184661;45222.32166517571;46384.07231855277;47484.575462736175;47533.04933901372;47918.76040619775;26718.594959316863;31350.686493134777;31655;31702.207444813143;32266;27299.454010920068;30741.92403265875;31684.841575792896;32361.676383235867;32477.675223247465;37347.43978840374;37376.252474949804;37432.625673742914;37508.81245593754;38451.807740961114;31638.525422119146;31639.734410623318;31914;32227.194320141247;32739.508907366886;24660.50678986446;24705.382365441008;24860.751392485843;25198;25250.873745631154 15:52:01 INFO - PROCESS | 1642 | |2;jquery.html;397.1183971583084;397.9621935916088;399.84605926718206;407.8062920112946;425.9510156332023;20888.37334879954;21441.820699861502;21733.45666358342;21926.794026328545;22203.44491387714;22345.10619575215;22803.087876484922;22811.201607943724;23292.417689557726;23378.415539611517;5875.059990401547;6164.044573091156;6172.166757487749;6187.102870083835;6188.47397971173;5825.359210486864;6010.519158467334;6017.849553761169;6068.484178844804;6103.115048317991;6014.188084608566;6023.518118550505;6026.487748541379;6026.548008899328;6033.034714445689;5768.913466298009;6000.729967151488;6068.757249710006;6070.2412198475195;6071.392860713938;5342.252084708144;5354.812581559627;5357.651752636105;5358.490943360374;5362.410134885159;13370.598882033555;13902.23537705436;14049;14061.086029408056;14076.366563504667;2285.4971906180613;2519.987400062988;2618.8428694278405;2622.5148347555764;2702.4730177615374;9007.774805629846;9996.100350968374;10243.436610986393;10430;10867.184961127947;1847.1226167570296;1877.9812201877944;1896.175163803736;1896.8767030143135;1897.4212865076147;119369;139329.6067039327;143331;146786;149619.25190374086;10931.508082136323;11058.612948546923;12110.81833772494;12182.878171218352;12436.937815310866;16454.588635283973;16480.09359485216;16512.83487165137;16519.33922643081;16527.843050986558;8885.289176865965;9037.367384283038;9066.863997040049;9101.726948191565;9128.178463938144;7462.805951047915;8716.43343182691;8826.955865220762;8827.867581986275;8999.010108888016;4910.140725373046;4916.287138364917;4920.950790492049;4945.579625731853;5004.624653151028;2006.137360934812;2050.7846676099093;2053.1376821734907;2053.1376821734907;2058.08415255213;785.4423359414765;863.7149740585592;895.7191216560382;896.3994123936978;918.4489306416096;21016.789832101484;22126.88936555307;22269;22285.77714222837;22344;917.4998130095437;930.6230976454547;935.5743136872707;944.9716508504756;949.0841338108759;8048.5170889746805;11414.600488982845;11500.539978400937;11686.649400517997;11718.589849355232;707872;742525;762624;775025;781853;80556;124191.42977521056;136391;136715;143865.28067359806;824.4023083264585;1016.4866742295094;1033.943133127685;1036.1917704190744;1038.0190719769896;14674.633134171305;20242.696359554324;20885.26901558438;20887.686684700046;20907.26824561133;58637.4136258649;58697.413025869195;58977.41022589891;59167.70416147892;61264.774704504765;89218;89837.55081224552;90129.74675633162;91468.71328216848;92147;7396.96301518489;8305.418620696493;8437.535935523605;8478.194571515696;8854.601542930712;9055.320850936338;13167.341632918124;13224.735505289647;13302.933485332898;13510.594682159552;11337.716557086138;11400.600978965696;11536.307821530734;11575.594854180063;11795.823062653895;9500.669906213274;9503.809923801347;10629.20280978945;10695.03744662984;10966.396848173426;11566.42167891619;11589.478473468545;11647.30116193031;11746.530138794353;12070.637880863587;8341.666333346599;8385.706500272461;8762.912370876209;8784.736457906272;8797.447311091571;8354.331653467587;11278.548858045586;11340.489677964346;11393.772124557298;11699.532018719156 15:52:01 INFO - PROCESS | 1642 | |3;mootools.html;1326.9601911942639;1367.753804315223;1367.7879928611069;1373.8351397832255;1402.432015033911;8215.794605134875;8596.785080372994;8606.999999999993;8610.655573777058;8617.784555386119;7629.122650895135;7873.8818917716135;8147.307478864303;8385.077641459435;8437.535935523543;2363.1847012780604;2396.8082553395775;2398.580248456522;2405.326508577601;2408.0969636386353;2367.7040369953756;2400.3039118655656;2405.6632071509916;2405.9398515037087;2406.723226828911;1740.8162449534311;2170.9782902171014;2257.492064285539;2339.508703172336;2367.3253122859987;2361.0909799727056;2371.6679664846847;2371.762823717632;2372.181597348912;2377.548265829487;2364.3379853640836;2366.4675448024227;2381.273711517986;2390.5099454611764;2391.892364843586;8476.406651534395;8542.402031857773;8545.273651739548;8555;8567.443116197428;5111.923321150186;5264.052470555299;5267.130923397634;5272.630915835893;5275.366955965309;3398.7790793598338;3533.081398836321;3572.3212589607892;3584.28314337131;3593.2993066352074;1203.3983008495752;1249.5189352099417;1253.7367152897903;1302.0690206502397;1307.5096838685492;10804.72988175294;10922.836157457645;10923.235373523856;10940;10942.726431839188;4541.43232095988;4679.368285281512;4699.389079419653;4775.379200703886;4776.713397196179;9575.186109180797;9583.712488625353;9595.664151754794;9595.952020239854;9613.51932403377;5325.733713314319;5331.866703332447;5331.920021199685;5336.733163341817;5346.91979620306;4330.956690433119;4387.648988080946;4842.854714358575;4879.902401951941;4899.338589290472;3353.7987720736833;3847.961520384816;3965.325894597925;3965.5836137205756;3993.4608827807874;1272.9045321600731;1278.8849003589721;1283.0633637444719;1288.4524077267124;1289.5937779599396;792.3898598079446;801.987970180436;817.0807841178674;817.9918200817916;827.4910929778264;5554.527865131509;5643.661380317194;5645.153227015899;5657.12314591239;5706.686132262683;571.5056476148102;591.5149577346534;596.4304089594427;599.5323647554827;599.8770252098309;3657.7988210648136;3736.7757934524016;3806.885793426202;3834.5973672764517;3834.9424758628643;9750.366226195416;10007.699769006942;10112.696619101438;10120.190384769201;10121.645742399129;10058.798824023479;10067;10072.899271007343;10079.748006299755;10134.037266459822;7639.541627502367;7837.059552853694;7841.059072911287;7969.123396426388;8000.919990800017;5237.947620523746;5243.501867322599;5297.708626025606;5712.942870571241;5892.234009578728;9081.863772043556;9263.980962094029;9288.489133097744;9431.764205894908;9439.433633981984;9034.774130646787;9400.247980161708;9430.575624096795;9488.810223795623;9494.24046076326;6689.364510371507;6884.65576721172;6899.068625735662;7208.17106032792;7368.6315684214505;7612.3148916597775;7738.458307918617;7930.088039875257;7951.960240198762;8063.556504392314;6812.693428795816;7015.438764898898;7028.964855175692;7051.964740176266;7155.212926578176;6721.395074443323;6912.170539535288;6919.37725604698;6952.304769523007;6980.406665433292;6293.905591416041;6464.159659244268;6516.902246466212;6524.836879078061;6561.639109849004;4985.501449854985;5037.874053148701;5044.747762611928;5096.770645320896;5132.973405318877;4917.409910810726;4997.325361076353;5050.090983622983;5132.897342053213;5219.295395121761 15:52:01 INFO - PROCESS | 1642 | |4;prototype.html;361.8118578339263;368.5466875742836;371.3723806766565;383.0939827308413;383.0958936908896;4808.495108013656;4939.357883475143;5065.86018145917;5117.820876269331;5295.761690723917;5008.323876276701;5052.545270925616;5084.771185296661;5091.287219789232;5113.309703190068;3651.872184473544;4027.7645906521943;4045.9076049466626;4068.9796551017203;4111.1366613011305;3429.9485507717404;3687.8340474678703;4106.958930410688;4115.464989551354;4132.8140233689555;3929.1159489115007;3932.508436445444;3932.6853851691794;3979.7214195006363;3989.085239085241;3100.2869340051916;3918.9804050979706;3926.429428228717;3930.76415415076;3946.072672921861;3425.794452332868;3429.451287793941;3436.1581412554083;3448.0000799768036;3458.2362994872547;4531;5036;5084.186530155157;5105.2086926526445;5105.9489405106215;4510.571495707903;4530.524294949048;4536.705114167568;4552.294394368878;4562.338460923148;5434.152388187996;5456.727163641842;5473.17902314652;5479.2466410748575;5505;3508.298340331944;3510.701590364822;3756.981215093907;3798.2593394288124;3812.866549670748;4673.112108699336;4715.976420117911;4776.546228108359;5672.7236371816425;5751.597388182787;3746.4380342948775;3817.770933743984;3862.729608927404;3879.437481565157;3879.631435013669;3163.430582495173;3903.375459926455;3931.272714547818;3937.251922134785;3948.427478015729;4381.430414046217;4473.644766425181;4523.660725445605;4533.750643714561;4537.682362234612;4629.930551041737;4748.406449193851;5344.121466386943;5465.961467321196;5517.172424136412;1182.2315494928366;1203.8435003449495;1226.8098444741079;1230.5569994801865;1252.8348635768823;808.1110778143994;864.1593406045209;872.0668884293744;877.4954401219325;889.8976617688919;4246.426732391088;4393.956060439355;4439.200943830077;4593.908121837611;4927.7536123193695;5037.672551284155;5082.822101226439;5092.949070509321;5355.98236335095;5402.621816472888;4870.293807397908;4890.896914326873;4939.555440010345;4939.654224204343;5020.899582008339;2508.1439734596634;2687.596860470906;2804.7195280472197;2818.0555416762368;2852.7575156111548;4559.703619264804;4829.058333624979;4965.925511117336;5076.6446348755235;5482.479164479368;4621.4223222097235;4803.903921921542;5376.93514696627;5418.945810541923;5430.321209848769;4542.182407166676;5101.51535604117;5389.568834493231;5526.877314317398;5533.924778208172;4869.756610429336;4888.728930478031;5277.076511610529;5283.524482796567;5305.469453054818;4701.670883038155;4880.0967622626495;5210.270562121382;5223.634345595772;5245.501677340647;4679.811568646111;4704.670673052853;4748.857534273978;5272.499112584298;5481;3092.412441636082;3425.160835595295;3455.101673564841;3564.803935783557;3690.206605579813;4387.3857659927;5033.974830125826;5225.346831646044;5271.815486457956;5275.841724748264;4540.296254080623;4651;5106.2595923590125;5112.233165025276;5117.795288188431;4429.291313389842;4444.622127161952;4529.6602754794185;5094.1849304111165;5098.597885581346;4546.976595415009;5038.546530812245;5080.771365288645;5270.420253772006;5329.520343169133;4577.519360467103;4963.875903102451;4982.75086245679;5449.673019618677;5482.725863706719;4772.045590881907;5227.843164705065;5285.973570132125;5304.9734751326;5310.761015754378 15:52:01 INFO - PROCESS | 1642 | |5;yui.html;682.2904179653161;770.1528318849266;795.2326005404786;865.3207232322626;872.515753756665;13402.66493337667;15137.848621513782;15780.526584202464;15812.683746325081;15825.841741582595;13376.66558336042;14473.421063157488;14594.562163135122;14642.926785366059;14646.41414343425;735.1619154164243;865.208334374047;866.3935245328264;866.8396346675854;867.535868310454;668.8028429111883;684.4421796236077;863.7667829685981;868.0581568997645;869.9260562852133;645.5706954875003;758.3743411685354;758.9848203035936;881.6781874615783;922.3866129024191;919.1038737231146;919.5264438814016;920.6179435534245;921.5115988526092;923.3167456082517;680.5780416142023;682.9624370659611;682.9760958366483;682.9795106146823;684.3567046975877;15332.923335383251;15426.614334641612;15509.612259693486;15537.223138843126;15604.531864044096;14003.789943150861;14335.49825756104;14344.64138396538;14355.425782968774;14399.78400323996;12576.37118144089;12718;12869.4208760606;13021.674458138623;13500.864991350158;4539.137563862855;4551.7724113794175;4562.589366956957;4575.176468235716;4585.816567337302;98472.50763746136;100626;105231;105427.99999999923;108062;9308.301877359225;10490.21323400748;11045.613403530839;11335.546578136948;11828.408579570987;21566.353009409744;22293.331200064025;22341;22370.88814555917;22379.992900319525;7660.2722741339485;7700.422468314899;7795.688172473037;7812.1016083150025;7951.522908625501;4285;4339.609435150852;4393.692441529062;4419.911601768011;4464.464264288306;3534.593521744981;3629.419292913174;3637.436197389409;3641.690456311243;3649.6897763689853;663.9203295604558;665.544102289933;671.754809494531;673.0846049372849;694.7741983855267;658.706875440434;669.1134247122582;674.8684006618761;676.8307923019245;727.240034164289;9347.672831450867;9781.706548803548;10154.339967902062;10213.416920377353;10401.427921464241;596.6843110940366;609.1624016976657;633.7560039384778;645.1645119570168;656.3370995294787;4511.661625378109;4874.610031197496;4882.487338829443;4902.975485122623;4933.186024305949;79751.60124199341;81158.78261826077;91503;98322.50838745903;101005.4849177263;97207;97375.02624973802;97587;99893.00213995825;101214;83071.16928830634;83859;84336.18678591054;85802;86434.56782716172;7665.156832748282;8592.570371481526;9597.424154550748;9609.135177833748;9623.807523849624;54829.72585137049;55112.72443637917;55523.16715249355;56095.43904560902;56122.1581676267;64377;68746;69601.65199173972;71768;72651;11144.498497567467;11185.608503702331;11567.710807229887;11706.70733231676;11912.344821034927;12137.21108127969;12173;12202.08484363694;12287.238799296467;12317.460317460318;11440.656780296604;11862.703432414259;11894.702632433913;11967.940160299491;12042.578509752117;11542.307461552333;11807.645770626896;11808.881911180779;11856.407179641155;13949.930250348683;13216.867831321564;13645;13654.52209172714;14215.786763198766;14228.217448040457;9938.552765125442;10228.39077646891;10287.53706083213;10567.735806604589;10654.57381704723;9894.75263118399;11207.271527350696;11341.943290283496;11463.31220126795;11784.528618855493 15:52:01 INFO - PROCESS | 1642 | __end_tp_report 15:52:01 INFO - PROCESS | 1642 | __start_cc_report 15:52:01 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1677 15:52:01 INFO - PROCESS | 1642 | __end_cc_report 15:52:01 INFO - PROCESS | 1642 | __startTimestamp1491519121138__endTimestamp 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | ------- Summary: start ------- 15:52:01 INFO - PROCESS | 1642 | Number of tests: 6 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5848.99 Median:6156.29 stddev:651.15 (10.6%) stddev-sans-first:626.28 15:52:01 INFO - PROCESS | 1642 | Values: 3489.2 3505.8 3522.4 3524.3 3568.1 5898.8 5908.9 5911.7 5939.0 5966.4 5818.0 5847.2 5853.3 5869.0 5878.2 5156.2 5217.3 5246.7 5251.3 5272.6 5235.8 5255.4 5264.1 5328.5 5332.2 5292.7 5312.9 5321.1 5336.3 5374.4 5332.2 5339.2 5350.7 5353.2 5373.1 4493.8 5182.7 5207.6 5298.0 5343.6 5759.8 5789.7 5798.9 5838.1 5843.1 6353.4 6356.9 6377.0 6384.8 6397.6 5285.8 6258.2 6295.0 6304.9 6322.1 5854.8 5900.6 5937.5 6004.2 6008.2 6289.7 6311.4 6314.9 6339.5 6391.3 6320.2 6322.3 6323.7 6334.0 6338.5 6296.5 6330.4 6350.8 6356.0 6356.6 5217.5 6182.2 6223.8 6280.0 6313.8 6348.7 6352.8 6366.1 6383.0 6387.2 5054.1 5058.4 5061.7 5066.2 5092.3 4424.4 4442.2 4481.1 4491.2 4501.3 5927.6 5971.1 5973.3 5997.1 6016.2 5684.9 6156.3 6332.9 6353.0 6368.4 5908.1 5919.4 5946.1 5958.8 5969.7 5549.6 5571.2 5571.2 5578.9 5608.5 6395.6 6410.1 6413.7 6423.4 6433.6 6217.3 6283.8 6288.8 6317.1 6317.4 6290.6 6325.5 6338.9 6365.4 6464.6 6345.3 6350.8 6370.1 6372.6 6382.7 6284.7 6307.8 6320.0 6323.4 6335.7 6118.1 6123.4 6241.6 6258.4 6293.3 6290.2 6322.9 6324.2 6336.9 6362.5 4946.9 6180.6 6188.3 6199.3 6220.1 6124.4 6166.4 6204.1 6217.7 6256.3 6160.5 6164.9 6194.8 6196.1 6204.3 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:68665.13 Median:3513.96 stddev:149221.01 (4246.5%) stddev-sans-first:149551.76 15:52:01 INFO - PROCESS | 1642 | Values: 466.4 486.9 498.6 522.3 544.7 25549.6 32893.0 32911.2 40618.8 41492.8 42799.1 43194.0 43267.8 43280.8 43383.3 8590.7 9381.8 9494.7 9701.2 9707.2 8840.3 9040.2 9487.3 9605.5 11684.0 11506.0 11732.7 11745.2 11748.6 11783.2 9948.9 11669.9 11778.7 11784.0 11901.6 11599.2 11665.9 11683.2 11685.1 11690.6 40044.2 40367.6 40410.6 40433.0 40439.4 4039.6 4049.3 4081.3 4117.2 4141.2 29606.3 30072.7 31581.5 31829.2 32117.0 3264.2 3316.2 3480.2 3512.7 3515.2 471641.3 475175.0 477254.0 477765.0 477999.0 62031.7 62133.7 62227.7 62353.0 62433.1 61787.0 63474.7 63513.7 63682.7 63816.4 16750.5 17350.7 17427.2 17482.9 17519.9 13268.7 13444.9 13582.0 13606.5 13632.6 11628.1 14383.4 14415.9 14634.3 15872.2 5726.6 6616.3 7832.5 7939.3 7970.9 641.0 836.1 836.8 843.8 866.7 30095.0 30139.4 30159.8 30392.2 30620.8 861.8 1076.4 1131.3 1139.7 1230.7 15736.0 15743.6 15755.3 15768.2 15969.4 629230.0 635256.0 635554.0 635917.0 636944.0 56589.4 57565.0 60383.8 60851.4 61417.7 1447.9 1476.6 1492.5 1492.8 1494.7 29952.0 31130.7 31143.8 31304.7 31765.0 50160.5 50701.0 50914.7 51010.0 51069.0 497862.0 501743.0 581179.0 581467.0 597883.0 25979.6 26822.9 26903.5 26911.0 26954.3 45222.3 46384.1 47484.6 47533.0 47918.8 26718.6 31350.7 31655.0 31702.2 32266.0 27299.5 30741.9 31684.8 32361.7 32477.7 37347.4 37376.3 37432.6 37508.8 38451.8 31638.5 31639.7 31914.0 32227.2 32739.5 24660.5 24705.4 24860.8 25198.0 25250.9 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40348.49 Median:1549.80 stddev:125268.53 (8082.9%) stddev-sans-first:125584.02 15:52:01 INFO - PROCESS | 1642 | Values: 397.1 398.0 399.8 407.8 426.0 20888.4 21441.8 21733.5 21926.8 22203.4 22345.1 22803.1 22811.2 23292.4 23378.4 5875.1 6164.0 6172.2 6187.1 6188.5 5825.4 6010.5 6017.8 6068.5 6103.1 6014.2 6023.5 6026.5 6026.5 6033.0 5768.9 6000.7 6068.8 6070.2 6071.4 5342.3 5354.8 5357.7 5358.5 5362.4 13370.6 13902.2 14049.0 14061.1 14076.4 2285.5 2520.0 2618.8 2622.5 2702.5 9007.8 9996.1 10243.4 10430.0 10867.2 1847.1 1878.0 1896.2 1896.9 1897.4 119369.0 139329.6 143331.0 146786.0 149619.3 10931.5 11058.6 12110.8 12182.9 12436.9 16454.6 16480.1 16512.8 16519.3 16527.8 8885.3 9037.4 9066.9 9101.7 9128.2 7462.8 8716.4 8827.0 8827.9 8999.0 4910.1 4916.3 4921.0 4945.6 5004.6 2006.1 2050.8 2053.1 2053.1 2058.1 785.4 863.7 895.7 896.4 918.4 21016.8 22126.9 22269.0 22285.8 22344.0 917.5 930.6 935.6 945.0 949.1 8048.5 11414.6 11500.5 11686.6 11718.6 707872.0 742525.0 762624.0 775025.0 781853.0 80556.0 124191.4 136391.0 136715.0 143865.3 824.4 1016.5 1033.9 1036.2 1038.0 14674.6 20242.7 20885.3 20887.7 20907.3 58637.4 58697.4 58977.4 59167.7 61264.8 89218.0 89837.6 90129.7 91468.7 92147.0 7397.0 8305.4 8437.5 8478.2 8854.6 9055.3 13167.3 13224.7 13302.9 13510.6 11337.7 11400.6 11536.3 11575.6 11795.8 9500.7 9503.8 10629.2 10695.0 10966.4 11566.4 11589.5 11647.3 11746.5 12070.6 8341.7 8385.7 8762.9 8784.7 8797.4 8354.3 11278.5 11340.5 11393.8 11699.5 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5469.22 Median:5240.72 stddev:2996.21 (57.2%) stddev-sans-first:2988.44 15:52:01 INFO - PROCESS | 1642 | Values: 1327.0 1367.8 1367.8 1373.8 1402.4 8215.8 8596.8 8607.0 8610.7 8617.8 7629.1 7873.9 8147.3 8385.1 8437.5 2363.2 2396.8 2398.6 2405.3 2408.1 2367.7 2400.3 2405.7 2405.9 2406.7 1740.8 2171.0 2257.5 2339.5 2367.3 2361.1 2371.7 2371.8 2372.2 2377.5 2364.3 2366.5 2381.3 2390.5 2391.9 8476.4 8542.4 8545.3 8555.0 8567.4 5111.9 5264.1 5267.1 5272.6 5275.4 3398.8 3533.1 3572.3 3584.3 3593.3 1203.4 1249.5 1253.7 1302.1 1307.5 10804.7 10922.8 10923.2 10940.0 10942.7 4541.4 4679.4 4699.4 4775.4 4776.7 9575.2 9583.7 9595.7 9596.0 9613.5 5325.7 5331.9 5331.9 5336.7 5346.9 4331.0 4387.6 4842.9 4879.9 4899.3 3353.8 3848.0 3965.3 3965.6 3993.5 1272.9 1278.9 1283.1 1288.5 1289.6 792.4 802.0 817.1 818.0 827.5 5554.5 5643.7 5645.2 5657.1 5706.7 571.5 591.5 596.4 599.5 599.9 3657.8 3736.8 3806.9 3834.6 3834.9 9750.4 10007.7 10112.7 10120.2 10121.6 10058.8 10067.0 10072.9 10079.7 10134.0 7639.5 7837.1 7841.1 7969.1 8000.9 5237.9 5243.5 5297.7 5712.9 5892.2 9081.9 9264.0 9288.5 9431.8 9439.4 9034.8 9400.2 9430.6 9488.8 9494.2 6689.4 6884.7 6899.1 7208.2 7368.6 7612.3 7738.5 7930.1 7952.0 8063.6 6812.7 7015.4 7029.0 7052.0 7155.2 6721.4 6912.2 6919.4 6952.3 6980.4 6293.9 6464.2 6516.9 6524.8 6561.6 4985.5 5037.9 5044.7 5096.8 5133.0 4917.4 4997.3 5050.1 5132.9 5219.3 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4275.72 Median:4710.32 stddev:1257.58 (26.7%) stddev-sans-first:1226.31 15:52:01 INFO - PROCESS | 1642 | Values: 361.8 368.5 371.4 383.1 383.1 4808.5 4939.4 5065.9 5117.8 5295.8 5008.3 5052.5 5084.8 5091.3 5113.3 3651.9 4027.8 4045.9 4069.0 4111.1 3429.9 3687.8 4107.0 4115.5 4132.8 3929.1 3932.5 3932.7 3979.7 3989.1 3100.3 3919.0 3926.4 3930.8 3946.1 3425.8 3429.5 3436.2 3448.0 3458.2 4531.0 5036.0 5084.2 5105.2 5105.9 4510.6 4530.5 4536.7 4552.3 4562.3 5434.2 5456.7 5473.2 5479.2 5505.0 3508.3 3510.7 3757.0 3798.3 3812.9 4673.1 4716.0 4776.5 5672.7 5751.6 3746.4 3817.8 3862.7 3879.4 3879.6 3163.4 3903.4 3931.3 3937.3 3948.4 4381.4 4473.6 4523.7 4533.8 4537.7 4629.9 4748.4 5344.1 5466.0 5517.2 1182.2 1203.8 1226.8 1230.6 1252.8 808.1 864.2 872.1 877.5 889.9 4246.4 4394.0 4439.2 4593.9 4927.8 5037.7 5082.8 5092.9 5356.0 5402.6 4870.3 4890.9 4939.6 4939.7 5020.9 2508.1 2687.6 2804.7 2818.1 2852.8 4559.7 4829.1 4965.9 5076.6 5482.5 4621.4 4803.9 5376.9 5418.9 5430.3 4542.2 5101.5 5389.6 5526.9 5533.9 4869.8 4888.7 5277.1 5283.5 5305.5 4701.7 4880.1 5210.3 5223.6 5245.5 4679.8 4704.7 4748.9 5272.5 5481.0 3092.4 3425.2 3455.1 3564.8 3690.2 4387.4 5034.0 5225.3 5271.8 5275.8 4540.3 4651.0 5106.3 5112.2 5117.8 4429.3 4444.6 4529.7 5094.2 5098.6 4547.0 5038.5 5080.8 5270.4 5329.5 4577.5 4963.9 4982.8 5449.7 5482.7 4772.0 5227.8 5286.0 5305.0 5310.8 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20596.43 Median:4580.50 stddev:29665.05 (647.6%) stddev-sans-first:29710.59 15:52:01 INFO - PROCESS | 1642 | Values: 682.3 770.2 795.2 865.3 872.5 13402.7 15137.8 15780.5 15812.7 15825.8 13376.7 14473.4 14594.6 14642.9 14646.4 735.2 865.2 866.4 866.8 867.5 668.8 684.4 863.8 868.1 869.9 645.6 758.4 759.0 881.7 922.4 919.1 919.5 920.6 921.5 923.3 680.6 683.0 683.0 683.0 684.4 15332.9 15426.6 15509.6 15537.2 15604.5 14003.8 14335.5 14344.6 14355.4 14399.8 12576.4 12718.0 12869.4 13021.7 13500.9 4539.1 4551.8 4562.6 4575.2 4585.8 98472.5 100626.0 105231.0 105428.0 108062.0 9308.3 10490.2 11045.6 11335.5 11828.4 21566.4 22293.3 22341.0 22370.9 22380.0 7660.3 7700.4 7795.7 7812.1 7951.5 4285.0 4339.6 4393.7 4419.9 4464.5 3534.6 3629.4 3637.4 3641.7 3649.7 663.9 665.5 671.8 673.1 694.8 658.7 669.1 674.9 676.8 727.2 9347.7 9781.7 10154.3 10213.4 10401.4 596.7 609.2 633.8 645.2 656.3 4511.7 4874.6 4882.5 4903.0 4933.2 79751.6 81158.8 91503.0 98322.5 101005.5 97207.0 97375.0 97587.0 99893.0 101214.0 83071.2 83859.0 84336.2 85802.0 86434.6 7665.2 8592.6 9597.4 9609.1 9623.8 54829.7 55112.7 55523.2 56095.4 56122.2 64377.0 68746.0 69601.7 71768.0 72651.0 11144.5 11185.6 11567.7 11706.7 11912.3 12137.2 12173.0 12202.1 12287.2 12317.5 11440.7 11862.7 11894.7 11967.9 12042.6 11542.3 11807.6 11808.9 11856.4 13949.9 13216.9 13645.0 13654.5 14215.8 14228.2 9938.6 10228.4 10287.5 10567.7 10654.6 9894.8 11207.3 11341.9 11463.3 11784.5 15:52:01 INFO - PROCESS | 1642 | -------- Summary: end -------- 15:52:01 INFO - PROCESS | 1642 | 15:52:01 INFO - TEST-INFO | 1642: exit 0 15:52:01 INFO - TEST-OK | dromaeo_css | took 1117101ms 15:52:01 INFO - TEST-START | kraken 15:52:01 INFO - operating with platform_type : mac_ 15:52:01 INFO - Initialising browser for kraken test... 15:52:01 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpdQCyTp/profile http://localhost:49242/getInfo.html) 15:52:03 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 15:52:03 INFO - PROCESS | 1651 | colorDepth:24 15:52:03 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 15:52:03 INFO - PROCESS | 1651 | __metrics 15:52:04 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:52:04 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:52:04 INFO - TEST-INFO | 1651: exit 0 15:52:04 INFO - Browser initialized. 15:52:04 INFO - Running cycle 1/1 for kraken test... 15:52:04 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpdQCyTp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:16 INFO - PROCESS | 1653 | RSS: Main: 163840000 15:52:16 INFO - PROCESS | 1653 | 15:52:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:20 INFO - PROCESS | 1653 | RSS: Main: 214724608 15:52:20 INFO - PROCESS | 1653 | 15:52:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 15:52:23 INFO - PROCESS | 1653 | RSS: Main: 227708928 15:52:23 INFO - PROCESS | 1653 | 15:52:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 15:52:27 INFO - PROCESS | 1653 | RSS: Main: 325070848 15:52:27 INFO - PROCESS | 1653 | 15:52:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 15:52:29 INFO - PROCESS | 1653 | RSS: Main: 228466688 15:52:29 INFO - PROCESS | 1653 | 15:52:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:32 INFO - PROCESS | 1653 | RSS: Main: 230621184 15:52:32 INFO - PROCESS | 1653 | 15:52:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:35 INFO - PROCESS | 1653 | RSS: Main: 269918208 15:52:35 INFO - PROCESS | 1653 | 15:52:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:39 INFO - PROCESS | 1653 | RSS: Main: 272740352 15:52:39 INFO - PROCESS | 1653 | 15:52:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 15:52:42 INFO - PROCESS | 1653 | RSS: Main: 268173312 15:52:42 INFO - PROCESS | 1653 | 15:52:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:45 INFO - PROCESS | 1653 | RSS: Main: 246370304 15:52:45 INFO - PROCESS | 1653 | 15:52:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:47 INFO - PROCESS | 1653 | RSS: Main: 247943168 15:52:47 INFO - PROCESS | 1653 | 15:52:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:50 INFO - PROCESS | 1653 | RSS: Main: 251924480 15:52:50 INFO - PROCESS | 1653 | 15:52:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:53 INFO - PROCESS | 1653 | RSS: Main: 258777088 15:52:53 INFO - PROCESS | 1653 | 15:52:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:57 INFO - PROCESS | 1653 | RSS: Main: 260030464 15:52:57 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 15:52:59 INFO - PROCESS | 1653 | RSS: Main: 304517120 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | __start_tp_report 15:52:59 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 15:52:59 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 15:52:59 INFO - PROCESS | 1653 | |i|pagename|runs| 15:52:59 INFO - PROCESS | 1653 | |0;ai-astar;104;112;113;114;112;113;112;112;112;113 15:52:59 INFO - PROCESS | 1653 | |1;audio-beat-detection;141;108;106;142;109;105;104;106;124;107 15:52:59 INFO - PROCESS | 1653 | |2;audio-dft;185;185;184;256;208;183;181;183;184;184 15:52:59 INFO - PROCESS | 1653 | |3;audio-fft;79;58;58;89;61;58;62;57;75;58 15:52:59 INFO - PROCESS | 1653 | |4;audio-oscillator;88;69;86;69;68;69;81;67;67;82 15:52:59 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;92;129;124;85;88;84;87;127;88;95 15:52:59 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;95;94;95;94;93;94;95;94;94 15:52:59 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;83;84;85;87;83;83;87;130;138 15:52:59 INFO - PROCESS | 1653 | |8;json-parse-financial;54;54;52;52;55;56;54;50;59;85 15:52:59 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;67;72;77;71;71;67;67;69;68;68 15:52:59 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;84;79;81;82;79;83;86;88;80;103 15:52:59 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;143;146;156;133;131;129;132;139;148;140 15:52:59 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;163;162;164;164;158;163;165;164;160;161 15:52:59 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;70;71;61;65;64;64;63;64;63;65 15:52:59 INFO - PROCESS | 1653 | __end_tp_report 15:52:59 INFO - PROCESS | 1653 | __start_cc_report 15:52:59 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1919 15:52:59 INFO - PROCESS | 1653 | __end_cc_report 15:52:59 INFO - PROCESS | 1653 | __startTimestamp1491519179261__endTimestamp 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | ------- Summary: start ------- 15:52:59 INFO - PROCESS | 1653 | Number of tests: 14 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.79 (2.5%) stddev-sans-first:0.73 15:52:59 INFO - PROCESS | 1653 | Values: 104.0 112.0 113.0 114.0 112.0 113.0 112.0 112.0 112.0 113.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:115.20 Median:108.50 stddev:14.97 (13.8%) stddev-sans-first:12.64 15:52:59 INFO - PROCESS | 1653 | Values: 141.0 108.0 106.0 142.0 109.0 105.0 104.0 106.0 124.0 107.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:193.30 Median:184.50 stddev:23.35 (12.7%) stddev-sans-first:24.58 15:52:59 INFO - PROCESS | 1653 | Values: 185.0 185.0 184.0 256.0 208.0 183.0 181.0 183.0 184.0 184.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.50 stddev:11.33 (18.4%) stddev-sans-first:10.91 15:52:59 INFO - PROCESS | 1653 | Values: 79.0 58.0 58.0 89.0 61.0 58.0 62.0 57.0 75.0 58.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:75.00 stddev:8.55 (11.4%) stddev-sans-first:7.57 15:52:59 INFO - PROCESS | 1653 | Values: 88.0 69.0 86.0 69.0 68.0 69.0 81.0 67.0 67.0 82.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:87.50 stddev:18.78 (21.5%) stddev-sans-first:19.70 15:52:59 INFO - PROCESS | 1653 | Values: 92.0 129.0 124.0 85.0 88.0 84.0 87.0 127.0 88.0 95.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 15:52:59 INFO - PROCESS | 1653 | Values: 94.0 95.0 94.0 95.0 94.0 93.0 94.0 95.0 94.0 94.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:84.50 stddev:20.96 (24.8%) stddev-sans-first:21.94 15:52:59 INFO - PROCESS | 1653 | Values: 85.0 83.0 84.0 85.0 87.0 83.0 83.0 87.0 130.0 138.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:54.50 stddev:10.10 (18.5%) stddev-sans-first:10.65 15:52:59 INFO - PROCESS | 1653 | Values: 54.0 54.0 52.0 52.0 55.0 56.0 54.0 50.0 59.0 85.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:3.16 (4.5%) stddev-sans-first:3.20 15:52:59 INFO - PROCESS | 1653 | Values: 67.0 72.0 77.0 71.0 71.0 67.0 67.0 69.0 68.0 68.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.50 stddev:7.14 (8.7%) stddev-sans-first:7.57 15:52:59 INFO - PROCESS | 1653 | Values: 84.0 79.0 81.0 82.0 79.0 83.0 86.0 88.0 80.0 103.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:141.50 stddev:8.69 (6.1%) stddev-sans-first:9.14 15:52:59 INFO - PROCESS | 1653 | Values: 143.0 146.0 156.0 133.0 131.0 129.0 132.0 139.0 148.0 140.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.50 stddev:2.17 (1.3%) stddev-sans-first:2.29 15:52:59 INFO - PROCESS | 1653 | Values: 163.0 162.0 164.0 164.0 158.0 163.0 165.0 164.0 160.0 161.0 15:52:59 INFO - PROCESS | 1653 | 15:52:59 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:3.13 (4.8%) stddev-sans-first:2.74 15:52:59 INFO - PROCESS | 1653 | Values: 70.0 71.0 61.0 65.0 64.0 64.0 63.0 64.0 63.0 65.0 15:52:59 INFO - PROCESS | 1653 | -------- Summary: end -------- 15:52:59 INFO - PROCESS | 1653 | 15:53:00 INFO - TEST-INFO | 1653: exit 0 15:53:00 INFO - TEST-OK | kraken | took 58374ms 15:53:00 INFO - SUITE-END | took 1175s 15:53:00 INFO - Completed test suite (00:19:35) 15:53:00 INFO - javascript benchmark 15:53:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3489.2149266415054, 3505.754597178197, 3522.418800897852, 3524.2951409718053, 3568.107973006748, 5898.764049438023, 5908.88182236355, 5911.704414779255, 5939.020061689821, 5966.403359664031, 5817.970910145444, 5847.239858818359, 5853.326867410249, 5868.970655146729, 5878.206442130311, 5156.20078887773, 5217.3217481727515, 5246.658967167122, 5251.291075704769, 5272.578193744491, 5235.764390602432, 5255.369355677324, 5264.131418315973, 5328.49379308965, 5332.200169974515, 5292.682439053649, 5312.867178320535, 5321.122014867542, 5336.332958380202, 5374.408815030343, 5332.226827110087, 5339.22581225722, 5350.652207606532, 5353.197020446925, 5373.113436283009, 4493.752843593601, 5182.689038657655, 5207.609429292818, 5298.046351656701, 5343.625946183769, 5759.827205183851, 5789.739461724233, 5798.9130163047585, 5838.065909454509, 5843.094320380348, 6353.364663533656, 6356.872862542723, 6377.043443483514, 6384.840378990516, 6397.616143031387, 5285.762140703678, 6258.24901011877, 6295.0, 6304.905426418607, 6322.114903913456, 5854.824355269348, 5900.616459930091, 5937.524998000106, 6004.219451471325, 6008.2370187177285, 6289.7169627366875, 6311.431971122529, 6314.873702525923, 6339.4611458025665, 6391.296957334689, 6320.178376810985, 6322.304546499881, 6323.683815809283, 6334.0, 6338.524610654219, 6296.496280297565, 6330.366963303725, 6350.7777227796805, 6355.9512680407215, 6356.586821856565, 5217.452167522356, 6182.165407669907, 6223.751049958041, 6279.96860015697, 6313.810585682437, 6348.682565871688, 6352.777652782131, 6366.076918846741, 6383.0, 6387.169667943231, 5054.064997975386, 5058.367704036996, 5061.6962982221185, 5066.214736715741, 5092.26162206478, 4424.424824772759, 4442.20040392726, 4481.126180394792, 4491.214037543416, 4501.3022981437925, 5927.585069045212, 5971.104334349882, 5973.283206015306, 5997.070454079625, 6016.1878146450545, 5684.914726279109, 6156.29202641702, 6332.873342533124, 6353.0, 6368.42684158428, 5908.05471124618, 5919.408059194132, 5946.07835785454, 5958.791442299499, 5969.701514924236, 5549.556035517229, 5571.192177134293, 5571.247881535941, 5578.9163162552595, 5608.495235428831, 6395.583078415243, 6410.134631824737, 6413.6793160341795, 6423.389777971085, 6433.613983161025, 6217.316095229611, 6283.842903927439, 6288.779892703734, 6317.147185129948, 6317.399847014526, 6290.591111577733, 6325.525585581007, 6338.904916426165, 6365.363463653597, 6464.644444555594, 6345.270293916259, 6350.809475715736, 6370.076338930921, 6372.649504277124, 6382.712777924911, 6284.717187726472, 6307.842303942438, 6320.020396838498, 6323.399277068671, 6335.746570137328, 6118.101457354478, 6123.4488895999575, 6241.625502469867, 6258.405451482102, 6293.339199383999, 6290.24517057956, 6322.873542529215, 6324.209473815773, 6336.904946425715, 6362.522810789117, 4946.876328091683, 6180.598261113013, 6188.2883468399905, 6199.256089269316, 6220.129181914626, 6124.3609037543765, 6166.414190651881, 6204.100405441095, 6217.720202590804, 6256.280527739368, 6160.537959652955, 6164.907526387018, 6194.752209911553, 6196.1015652731, 6204.286507051566], "value": 5808.737392622759, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.44493053266586, 486.9245266983619, 498.606101180068, 522.2949018824586, 544.7439703339429, 25549.616755748677, 32893.01320960375, 32911.177220569465, 40618.79690601543, 41492.792536037356, 42799.14401711964, 43194.0, 43267.78366108173, 43280.78359608197, 43383.34924976128, 8590.699325523608, 9381.765455863624, 9494.715158545254, 9701.223902087851, 9707.223422126213, 8840.33697472689, 9040.186383225508, 9487.28845336599, 9605.519724013771, 11684.0, 11506.0, 11732.706682332924, 11745.177837551375, 11748.647540573797, 11783.234089784179, 9948.850767238497, 11669.941650291694, 11778.705532361673, 11783.998360139398, 11901.58344457944, 11599.246049006788, 11665.941670291679, 11683.182177247596, 11685.12361572877, 11690.649280521598, 40044.19911601781, 40367.59632403668, 40410.59589404098, 40432.98917527085, 40439.393409098884, 4039.5560685785263, 4049.250888585621, 4081.285774989365, 4117.238310912461, 4141.233871733709, 29606.25984350387, 30072.69927300721, 31581.526277105862, 31829.204269893205, 32117.0, 3264.2329052672603, 3316.2372654289406, 3480.1821571930577, 3512.7189824813954, 3515.2090779574646, 471641.2835871666, 475174.99999999657, 477254.0, 477765.0, 477999.0, 62031.68984155141, 62133.689331553054, 62227.68886155631, 62353.0, 62433.06350404747, 61787.0, 63474.682626586575, 63513.729725406156, 63682.68158659177, 63816.36183638197, 16750.497485075466, 17350.739738903925, 17427.215775290144, 17482.912585437247, 17519.912400437915, 13268.668283292802, 13444.932775336256, 13582.049256551947, 13606.523771667944, 13632.591022269347, 11628.069754419626, 14383.424663013571, 14415.855841441451, 14634.341454634567, 15872.206389680701, 5726.599138060295, 6616.305287944792, 7832.490888092256, 7939.325157361689, 7970.9202907970175, 640.9839754006188, 836.0970152235572, 836.8159005018886, 843.7806170395742, 866.7096522664978, 30095.0, 30139.397212056076, 30159.849200753855, 30392.240193995327, 30620.84689576538, 861.7587075618836, 1076.4348716923678, 1131.3268605179906, 1139.6751925701135, 1230.686175025363, 15736.0, 15743.606409839846, 15755.291011904492, 15768.211589420484, 15969.361225550847, 629230.0, 635256.0, 635554.0, 635917.0, 636944.0, 56589.43410565924, 57565.0, 60383.79232415327, 60851.39148608457, 61417.69291153605, 1447.9131252124905, 1476.5865557643876, 1492.5074725340394, 1492.8208614966275, 1494.686115915648, 29951.951681691036, 31130.688693113683, 31143.844280778452, 31304.686953130178, 31765.0, 50160.49839501558, 50701.0, 50914.74542627263, 51010.0, 51069.0, 497862.0, 501743.0, 581179.0, 581467.0, 597883.0, 25979.610305845807, 26822.865885671228, 26903.461930760885, 26911.0, 26954.32614184661, 45222.32166517571, 46384.07231855277, 47484.575462736175, 47533.04933901372, 47918.76040619775, 26718.594959316863, 31350.686493134777, 31655.0, 31702.207444813143, 32266.0, 27299.454010920068, 30741.92403265875, 31684.841575792896, 32361.676383235867, 32477.675223247465, 37347.43978840374, 37376.252474949804, 37432.625673742914, 37508.81245593754, 38451.807740961114, 31638.525422119146, 31639.734410623318, 31914.0, 32227.194320141247, 32739.508907366886, 24660.50678986446, 24705.382365441008, 24860.751392485843, 25198.0, 25250.873745631154], "value": 19938.85973935913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.1183971583084, 397.9621935916088, 399.84605926718206, 407.8062920112946, 425.9510156332023, 20888.37334879954, 21441.820699861502, 21733.45666358342, 21926.794026328545, 22203.44491387714, 22345.10619575215, 22803.087876484922, 22811.201607943724, 23292.417689557726, 23378.415539611517, 5875.059990401547, 6164.044573091156, 6172.166757487749, 6187.102870083835, 6188.47397971173, 5825.359210486864, 6010.519158467334, 6017.849553761169, 6068.484178844804, 6103.115048317991, 6014.188084608566, 6023.518118550505, 6026.487748541379, 6026.548008899328, 6033.034714445689, 5768.913466298009, 6000.729967151488, 6068.757249710006, 6070.2412198475195, 6071.392860713938, 5342.252084708144, 5354.812581559627, 5357.651752636105, 5358.490943360374, 5362.410134885159, 13370.598882033555, 13902.23537705436, 14049.0, 14061.086029408056, 14076.366563504667, 2285.4971906180613, 2519.987400062988, 2618.8428694278405, 2622.5148347555764, 2702.4730177615374, 9007.774805629846, 9996.100350968374, 10243.436610986393, 10430.0, 10867.184961127947, 1847.1226167570296, 1877.9812201877944, 1896.175163803736, 1896.8767030143135, 1897.4212865076147, 119369.0, 139329.6067039327, 143331.0, 146786.0, 149619.25190374086, 10931.508082136323, 11058.612948546923, 12110.81833772494, 12182.878171218352, 12436.937815310866, 16454.588635283973, 16480.09359485216, 16512.83487165137, 16519.33922643081, 16527.843050986558, 8885.289176865965, 9037.367384283038, 9066.863997040049, 9101.726948191565, 9128.178463938144, 7462.805951047915, 8716.43343182691, 8826.955865220762, 8827.867581986275, 8999.010108888016, 4910.140725373046, 4916.287138364917, 4920.950790492049, 4945.579625731853, 5004.624653151028, 2006.137360934812, 2050.7846676099093, 2053.1376821734907, 2053.1376821734907, 2058.08415255213, 785.4423359414765, 863.7149740585592, 895.7191216560382, 896.3994123936978, 918.4489306416096, 21016.789832101484, 22126.88936555307, 22269.0, 22285.77714222837, 22344.0, 917.4998130095437, 930.6230976454547, 935.5743136872707, 944.9716508504756, 949.0841338108759, 8048.5170889746805, 11414.600488982845, 11500.539978400937, 11686.649400517997, 11718.589849355232, 707872.0, 742525.0, 762624.0, 775025.0, 781853.0, 80556.0, 124191.42977521056, 136391.0, 136715.0, 143865.28067359806, 824.4023083264585, 1016.4866742295094, 1033.943133127685, 1036.1917704190744, 1038.0190719769896, 14674.633134171305, 20242.696359554324, 20885.26901558438, 20887.686684700046, 20907.26824561133, 58637.4136258649, 58697.413025869195, 58977.41022589891, 59167.70416147892, 61264.774704504765, 89218.0, 89837.55081224552, 90129.74675633162, 91468.71328216848, 92147.0, 7396.96301518489, 8305.418620696493, 8437.535935523605, 8478.194571515696, 8854.601542930712, 9055.320850936338, 13167.341632918124, 13224.735505289647, 13302.933485332898, 13510.594682159552, 11337.716557086138, 11400.600978965696, 11536.307821530734, 11575.594854180063, 11795.823062653895, 9500.669906213274, 9503.809923801347, 10629.20280978945, 10695.03744662984, 10966.396848173426, 11566.42167891619, 11589.478473468545, 11647.30116193031, 11746.530138794353, 12070.637880863587, 8341.666333346599, 8385.706500272461, 8762.912370876209, 8784.736457906272, 8797.447311091571, 8354.331653467587, 11278.548858045586, 11340.489677964346, 11393.772124557298, 11699.532018719156], "value": 9820.52347175313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.9601911942639, 1367.753804315223, 1367.7879928611069, 1373.8351397832255, 1402.432015033911, 8215.794605134875, 8596.785080372994, 8606.999999999993, 8610.655573777058, 8617.784555386119, 7629.122650895135, 7873.8818917716135, 8147.307478864303, 8385.077641459435, 8437.535935523543, 2363.1847012780604, 2396.8082553395775, 2398.580248456522, 2405.326508577601, 2408.0969636386353, 2367.7040369953756, 2400.3039118655656, 2405.6632071509916, 2405.9398515037087, 2406.723226828911, 1740.8162449534311, 2170.9782902171014, 2257.492064285539, 2339.508703172336, 2367.3253122859987, 2361.0909799727056, 2371.6679664846847, 2371.762823717632, 2372.181597348912, 2377.548265829487, 2364.3379853640836, 2366.4675448024227, 2381.273711517986, 2390.5099454611764, 2391.892364843586, 8476.406651534395, 8542.402031857773, 8545.273651739548, 8555.0, 8567.443116197428, 5111.923321150186, 5264.052470555299, 5267.130923397634, 5272.630915835893, 5275.366955965309, 3398.7790793598338, 3533.081398836321, 3572.3212589607892, 3584.28314337131, 3593.2993066352074, 1203.3983008495752, 1249.5189352099417, 1253.7367152897903, 1302.0690206502397, 1307.5096838685492, 10804.72988175294, 10922.836157457645, 10923.235373523856, 10940.0, 10942.726431839188, 4541.43232095988, 4679.368285281512, 4699.389079419653, 4775.379200703886, 4776.713397196179, 9575.186109180797, 9583.712488625353, 9595.664151754794, 9595.952020239854, 9613.51932403377, 5325.733713314319, 5331.866703332447, 5331.920021199685, 5336.733163341817, 5346.91979620306, 4330.956690433119, 4387.648988080946, 4842.854714358575, 4879.902401951941, 4899.338589290472, 3353.7987720736833, 3847.961520384816, 3965.325894597925, 3965.5836137205756, 3993.4608827807874, 1272.9045321600731, 1278.8849003589721, 1283.0633637444719, 1288.4524077267124, 1289.5937779599396, 792.3898598079446, 801.987970180436, 817.0807841178674, 817.9918200817916, 827.4910929778264, 5554.527865131509, 5643.661380317194, 5645.153227015899, 5657.12314591239, 5706.686132262683, 571.5056476148102, 591.5149577346534, 596.4304089594427, 599.5323647554827, 599.8770252098309, 3657.7988210648136, 3736.7757934524016, 3806.885793426202, 3834.5973672764517, 3834.9424758628643, 9750.366226195416, 10007.699769006942, 10112.696619101438, 10120.190384769201, 10121.645742399129, 10058.798824023479, 10067.0, 10072.899271007343, 10079.748006299755, 10134.037266459822, 7639.541627502367, 7837.059552853694, 7841.059072911287, 7969.123396426388, 8000.919990800017, 5237.947620523746, 5243.501867322599, 5297.708626025606, 5712.942870571241, 5892.234009578728, 9081.863772043556, 9263.980962094029, 9288.489133097744, 9431.764205894908, 9439.433633981984, 9034.774130646787, 9400.247980161708, 9430.575624096795, 9488.810223795623, 9494.24046076326, 6689.364510371507, 6884.65576721172, 6899.068625735662, 7208.17106032792, 7368.6315684214505, 7612.3148916597775, 7738.458307918617, 7930.088039875257, 7951.960240198762, 8063.556504392314, 6812.693428795816, 7015.438764898898, 7028.964855175692, 7051.964740176266, 7155.212926578176, 6721.395074443323, 6912.170539535288, 6919.37725604698, 6952.304769523007, 6980.406665433292, 6293.905591416041, 6464.159659244268, 6516.902246466212, 6524.836879078061, 6561.639109849004, 4985.501449854985, 5037.874053148701, 5044.747762611928, 5096.770645320896, 5132.973405318877, 4917.409910810726, 4997.325361076353, 5050.090983622983, 5132.897342053213, 5219.295395121761], "value": 4392.195675894604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8118578339263, 368.5466875742836, 371.3723806766565, 383.0939827308413, 383.0958936908896, 4808.495108013656, 4939.357883475143, 5065.86018145917, 5117.820876269331, 5295.761690723917, 5008.323876276701, 5052.545270925616, 5084.771185296661, 5091.287219789232, 5113.309703190068, 3651.872184473544, 4027.7645906521943, 4045.9076049466626, 4068.9796551017203, 4111.1366613011305, 3429.9485507717404, 3687.8340474678703, 4106.958930410688, 4115.464989551354, 4132.8140233689555, 3929.1159489115007, 3932.508436445444, 3932.6853851691794, 3979.7214195006363, 3989.085239085241, 3100.2869340051916, 3918.9804050979706, 3926.429428228717, 3930.76415415076, 3946.072672921861, 3425.794452332868, 3429.451287793941, 3436.1581412554083, 3448.0000799768036, 3458.2362994872547, 4531.0, 5036.0, 5084.186530155157, 5105.2086926526445, 5105.9489405106215, 4510.571495707903, 4530.524294949048, 4536.705114167568, 4552.294394368878, 4562.338460923148, 5434.152388187996, 5456.727163641842, 5473.17902314652, 5479.2466410748575, 5505.0, 3508.298340331944, 3510.701590364822, 3756.981215093907, 3798.2593394288124, 3812.866549670748, 4673.112108699336, 4715.976420117911, 4776.546228108359, 5672.7236371816425, 5751.597388182787, 3746.4380342948775, 3817.770933743984, 3862.729608927404, 3879.437481565157, 3879.631435013669, 3163.430582495173, 3903.375459926455, 3931.272714547818, 3937.251922134785, 3948.427478015729, 4381.430414046217, 4473.644766425181, 4523.660725445605, 4533.750643714561, 4537.682362234612, 4629.930551041737, 4748.406449193851, 5344.121466386943, 5465.961467321196, 5517.172424136412, 1182.2315494928366, 1203.8435003449495, 1226.8098444741079, 1230.5569994801865, 1252.8348635768823, 808.1110778143994, 864.1593406045209, 872.0668884293744, 877.4954401219325, 889.8976617688919, 4246.426732391088, 4393.956060439355, 4439.200943830077, 4593.908121837611, 4927.7536123193695, 5037.672551284155, 5082.822101226439, 5092.949070509321, 5355.98236335095, 5402.621816472888, 4870.293807397908, 4890.896914326873, 4939.555440010345, 4939.654224204343, 5020.899582008339, 2508.1439734596634, 2687.596860470906, 2804.7195280472197, 2818.0555416762368, 2852.7575156111548, 4559.703619264804, 4829.058333624979, 4965.925511117336, 5076.6446348755235, 5482.479164479368, 4621.4223222097235, 4803.903921921542, 5376.93514696627, 5418.945810541923, 5430.321209848769, 4542.182407166676, 5101.51535604117, 5389.568834493231, 5526.877314317398, 5533.924778208172, 4869.756610429336, 4888.728930478031, 5277.076511610529, 5283.524482796567, 5305.469453054818, 4701.670883038155, 4880.0967622626495, 5210.270562121382, 5223.634345595772, 5245.501677340647, 4679.811568646111, 4704.670673052853, 4748.857534273978, 5272.499112584298, 5481.0, 3092.412441636082, 3425.160835595295, 3455.101673564841, 3564.803935783557, 3690.206605579813, 4387.3857659927, 5033.974830125826, 5225.346831646044, 5271.815486457956, 5275.841724748264, 4540.296254080623, 4651.0, 5106.2595923590125, 5112.233165025276, 5117.795288188431, 4429.291313389842, 4444.622127161952, 4529.6602754794185, 5094.1849304111165, 5098.597885581346, 4546.976595415009, 5038.546530812245, 5080.771365288645, 5270.420253772006, 5329.520343169133, 4577.519360467103, 4963.875903102451, 4982.75086245679, 5449.673019618677, 5482.725863706719, 4772.045590881907, 5227.843164705065, 5285.973570132125, 5304.9734751326, 5310.761015754378], "value": 3894.9888283638734, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.2904179653161, 770.1528318849266, 795.2326005404786, 865.3207232322626, 872.515753756665, 13402.66493337667, 15137.848621513782, 15780.526584202464, 15812.683746325081, 15825.841741582595, 13376.66558336042, 14473.421063157488, 14594.562163135122, 14642.926785366059, 14646.41414343425, 735.1619154164243, 865.208334374047, 866.3935245328264, 866.8396346675854, 867.535868310454, 668.8028429111883, 684.4421796236077, 863.7667829685981, 868.0581568997645, 869.9260562852133, 645.5706954875003, 758.3743411685354, 758.9848203035936, 881.6781874615783, 922.3866129024191, 919.1038737231146, 919.5264438814016, 920.6179435534245, 921.5115988526092, 923.3167456082517, 680.5780416142023, 682.9624370659611, 682.9760958366483, 682.9795106146823, 684.3567046975877, 15332.923335383251, 15426.614334641612, 15509.612259693486, 15537.223138843126, 15604.531864044096, 14003.789943150861, 14335.49825756104, 14344.64138396538, 14355.425782968774, 14399.78400323996, 12576.37118144089, 12718.0, 12869.4208760606, 13021.674458138623, 13500.864991350158, 4539.137563862855, 4551.7724113794175, 4562.589366956957, 4575.176468235716, 4585.816567337302, 98472.50763746136, 100626.0, 105231.0, 105427.99999999923, 108062.0, 9308.301877359225, 10490.21323400748, 11045.613403530839, 11335.546578136948, 11828.408579570987, 21566.353009409744, 22293.331200064025, 22341.0, 22370.88814555917, 22379.992900319525, 7660.2722741339485, 7700.422468314899, 7795.688172473037, 7812.1016083150025, 7951.522908625501, 4285.0, 4339.609435150852, 4393.692441529062, 4419.911601768011, 4464.464264288306, 3534.593521744981, 3629.419292913174, 3637.436197389409, 3641.690456311243, 3649.6897763689853, 663.9203295604558, 665.544102289933, 671.754809494531, 673.0846049372849, 694.7741983855267, 658.706875440434, 669.1134247122582, 674.8684006618761, 676.8307923019245, 727.240034164289, 9347.672831450867, 9781.706548803548, 10154.339967902062, 10213.416920377353, 10401.427921464241, 596.6843110940366, 609.1624016976657, 633.7560039384778, 645.1645119570168, 656.3370995294787, 4511.661625378109, 4874.610031197496, 4882.487338829443, 4902.975485122623, 4933.186024305949, 79751.60124199341, 81158.78261826077, 91503.0, 98322.50838745903, 101005.4849177263, 97207.0, 97375.02624973802, 97587.0, 99893.00213995825, 101214.0, 83071.16928830634, 83859.0, 84336.18678591054, 85802.0, 86434.56782716172, 7665.156832748282, 8592.570371481526, 9597.424154550748, 9609.135177833748, 9623.807523849624, 54829.72585137049, 55112.72443637917, 55523.16715249355, 56095.43904560902, 56122.1581676267, 64377.0, 68746.0, 69601.65199173972, 71768.0, 72651.0, 11144.498497567467, 11185.608503702331, 11567.710807229887, 11706.70733231676, 11912.344821034927, 12137.21108127969, 12173.0, 12202.08484363694, 12287.238799296467, 12317.460317460318, 11440.656780296604, 11862.703432414259, 11894.702632433913, 11967.940160299491, 12042.578509752117, 11542.307461552333, 11807.645770626896, 11808.881911180779, 11856.407179641155, 13949.930250348683, 13216.867831321564, 13645.0, 13654.52209172714, 14215.786763198766, 14228.217448040457, 9938.552765125442, 10228.39077646891, 10287.53706083213, 10567.735806604589, 10654.57381704723, 9894.75263118399, 11207.271527350696, 11341.943290283496, 11463.31220126795, 11784.528618855493], "value": 7468.467510652732, "unit": "score"}], "name": "dromaeo_css", "value": 7250.996049524537, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 114.0, 112.0, 113.0, 112.0, 112.0, 112.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 106.0, 142.0, 109.0, 105.0, 104.0, 106.0, 124.0, 107.0], "value": 115.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 256.0, 208.0, 183.0, 181.0, 183.0, 184.0, 184.0], "value": 193.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 89.0, 61.0, 58.0, 62.0, 57.0, 75.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 86.0, 69.0, 68.0, 69.0, 81.0, 67.0, 67.0, 82.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 129.0, 124.0, 85.0, 88.0, 84.0, 87.0, 127.0, 88.0, 95.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 85.0, 87.0, 83.0, 83.0, 87.0, 130.0, 138.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 52.0, 55.0, 56.0, 54.0, 50.0, 59.0, 85.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 77.0, 71.0, 71.0, 67.0, 67.0, 69.0, 68.0, 68.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 81.0, 82.0, 79.0, 83.0, 86.0, 88.0, 80.0, 103.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 156.0, 133.0, 131.0, 129.0, 132.0, 139.0, 148.0, 140.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 164.0, 158.0, 163.0, 165.0, 164.0, 160.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 61.0, 65.0, 64.0, 64.0, 63.0, 64.0, 63.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1427.3000000000004, "alertThreshold": 2.0}]} 15:53:00 INFO - Return code: 0 15:53:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:00 INFO - # TBPL SUCCESS # 15:53:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:00 INFO - 2017-04-06 15:53:00.583 screenresolution[1657:9617] starting screenresolution argv=screenresolution get 15:53:00 INFO - 2017-04-06 15:53:00.586 screenresolution[1657:9617] Display 0: 1600x1200x32@60 15:53:00 INFO - 2017-04-06 15:53:00.592 screenresolution[1658:9622] starting screenresolution argv=screenresolution list 15:53:00 INFO - Available Modes on Display 0 15:53:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:00 INFO - Intel Iris: 15:53:00 INFO - Chipset Model: Intel Iris 15:53:00 INFO - Type: GPU 15:53:00 INFO - Bus: Built-In 15:53:00 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:00 INFO - Vendor: Intel (0x8086) 15:53:00 INFO - Device ID: 0x0a2e 15:53:00 INFO - Revision ID: 0x0009 15:53:00 INFO - Displays: 15:53:00 INFO - Display: 15:53:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:00 INFO - Display Serial Number: 1600x1200 60 15:53:00 INFO - Main Display: Yes 15:53:00 INFO - Mirror: Off 15:53:00 INFO - Online: Yes 15:53:00 INFO - Rotation: Supported 15:53:00 INFO - Return code: 0 15:53:00 INFO - Running post-action listener: _resource_record_post_action 15:53:00 INFO - [mozharness: 2017-04-06 22:53:00.827744Z] Finished run-tests step (success) 15:53:00 INFO - Running post-run listener: _resource_record_post_run 15:53:00 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 37213184; Write bytes: 420461568; Read time: 236; Write time: 1365 15:53:00 INFO - TinderboxPrint: CPU usage
53.6% 15:53:00 INFO - TinderboxPrint: I/O read bytes / time
37,213,184 / 236 15:53:00 INFO - TinderboxPrint: I/O write bytes / time
420,461,568 / 1,365 15:53:00 INFO - TinderboxPrint: CPU idle
2,213.0 (46.4%) 15:53:00 INFO - TinderboxPrint: CPU system
949.6 (19.9%) 15:53:00 INFO - TinderboxPrint: CPU user
1,603.0 (33.6%) 15:53:00 INFO - TinderboxPrint: Swap in / out
158,707,712 / 0 15:53:00 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121481728; Write bytes: 113795072; Read time: 11082; Write time: 248 15:53:00 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34477056; Write bytes: 296553472; Read time: 215; Write time: 1082 15:53:01 INFO - Running post-run listener: _upload_blobber_files 15:53:01 INFO - Blob upload gear active. 15:53:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:53:01 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:02 INFO - (blobuploader) - INFO - Done attempting. 15:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:03 INFO - (blobuploader) - INFO - Done attempting. 15:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:04 INFO - (blobuploader) - INFO - Done attempting. 15:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:06 INFO - (blobuploader) - INFO - Done attempting. 15:53:06 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:06 INFO - Return code: 0 15:53:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df597cf9d1d0cbfb41a6cafef84319b45481f9a0dd32af2e07747c571cfd7a1f3ae820dc3eb58cbb7a54df21485705953c511f5398cf9a7120a256cab0b9cdce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6fc19f39279b638c3dda5fe04731b1278e2905e56af0d0c0f3e467310f1f15ea89ba6b7e3327048780613492e3c27b2a3153e01508bd217043befae4141f8181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0f7c2efdf7d95018962dba1aa7163e95681f346133eaf47dd822a7c53a2f2a8ba694f8ea93120f7025a032e253fea122db784e9f91223e9779382d2a5e76d01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73ff3869e97991720b9fb43d059c34d64cc06f7ce10663af68cef501b10db7d7d8fc362cc564b4553fa0e712a86487fc4065e234c3122f5435d6b7b76e7aa6a6"} 15:53:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:06 INFO - Contents: 15:53:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df597cf9d1d0cbfb41a6cafef84319b45481f9a0dd32af2e07747c571cfd7a1f3ae820dc3eb58cbb7a54df21485705953c511f5398cf9a7120a256cab0b9cdce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6fc19f39279b638c3dda5fe04731b1278e2905e56af0d0c0f3e467310f1f15ea89ba6b7e3327048780613492e3c27b2a3153e01508bd217043befae4141f8181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0f7c2efdf7d95018962dba1aa7163e95681f346133eaf47dd822a7c53a2f2a8ba694f8ea93120f7025a032e253fea122db784e9f91223e9779382d2a5e76d01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73ff3869e97991720b9fb43d059c34d64cc06f7ce10663af68cef501b10db7d7d8fc362cc564b4553fa0e712a86487fc4065e234c3122f5435d6b7b76e7aa6a6"} 15:53:06 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:06 INFO - Copying logs to upload dir... 15:53:06 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.270230 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-04-06 15:53:06.511468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 15:53:06.515657) ========= 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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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/df597cf9d1d0cbfb41a6cafef84319b45481f9a0dd32af2e07747c571cfd7a1f3ae820dc3eb58cbb7a54df21485705953c511f5398cf9a7120a256cab0b9cdce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6fc19f39279b638c3dda5fe04731b1278e2905e56af0d0c0f3e467310f1f15ea89ba6b7e3327048780613492e3c27b2a3153e01508bd217043befae4141f8181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0f7c2efdf7d95018962dba1aa7163e95681f346133eaf47dd822a7c53a2f2a8ba694f8ea93120f7025a032e253fea122db784e9f91223e9779382d2a5e76d01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73ff3869e97991720b9fb43d059c34d64cc06f7ce10663af68cef501b10db7d7d8fc362cc564b4553fa0e712a86487fc4065e234c3122f5435d6b7b76e7aa6a6"} build_url:https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/CnTM6hYxRMWy3_Fq5AXMMg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df597cf9d1d0cbfb41a6cafef84319b45481f9a0dd32af2e07747c571cfd7a1f3ae820dc3eb58cbb7a54df21485705953c511f5398cf9a7120a256cab0b9cdce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6fc19f39279b638c3dda5fe04731b1278e2905e56af0d0c0f3e467310f1f15ea89ba6b7e3327048780613492e3c27b2a3153e01508bd217043befae4141f8181", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0f7c2efdf7d95018962dba1aa7163e95681f346133eaf47dd822a7c53a2f2a8ba694f8ea93120f7025a032e253fea122db784e9f91223e9779382d2a5e76d01", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/73ff3869e97991720b9fb43d059c34d64cc06f7ce10663af68cef501b10db7d7d8fc362cc564b4553fa0e712a86487fc4065e234c3122f5435d6b7b76e7aa6a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 15:53:06.549977) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 15:53:06.550338) ========= 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.uMbyOF8CYO/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.5fE0JJFWfW/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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.005120 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 15:53:06.600856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 15:53:06.601453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 15:53:06.602063) ========= ========= Total master_lag: 0.18 =========