builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0344 starttime: 1492795419.5 results: success (0) buildid: 20170421072927 builduid: 8c567a83b73d46fd89e6e21d15541005 revision: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.504859) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.505310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.505633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.533126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.533646) ========= 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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-21 10:23:39-- 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% 20.2M=0.001s 2017-04-21 10:23:39 (20.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.272959 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.946888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.947240) ========= 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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.028606 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:39.999418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 10:23:39.999775) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e --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 ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y4xHxT5aYj/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.aR91RM9WO8/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-21 10:23:40,107 truncating revision to first 12 chars 2017-04-21 10:23:40,107 Setting DEBUG logging. 2017-04-21 10:23:40,107 attempt 1/10 2017-04-21 10:23:40,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ca38cf3eba17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 10:23:42,286 unpacking tar archive at: mozilla-beta-ca38cf3eba17/testing/mozharness/ program finished with exit code 0 elapsedTime=2.473226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 10:23:42.497126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:42.497420) ========= script_repo_revision: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:42.497789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:42.498066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:23:42.518232) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-21 10:23:42.518526) ========= /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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:23:42 INFO - MultiFileLogger online at 20170421 10:23:42 in /builds/slave/test 10:23:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:23:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:23:42 INFO - {'append_to_log': False, 10:23:42 INFO - 'base_work_dir': '/builds/slave/test', 10:23:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:23:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:23:42 INFO - 'branch': 'Mozilla-Beta', 10:23:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:23:42 INFO - 'config_files': ('talos/mac_config.py',), 10:23:42 INFO - 'default_actions': ('clobber', 10:23:42 INFO - 'read-buildbot-config', 10:23:42 INFO - 'download-and-extract', 10:23:42 INFO - 'populate-webroot', 10:23:42 INFO - 'create-virtualenv', 10:23:42 INFO - 'install', 10:23:42 INFO - 'run-tests'), 10:23:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:23:42 INFO - 'download_minidump_stackwalk': True, 10:23:42 INFO - 'download_symbols': 'ondemand', 10:23:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:23:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:23:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:23:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:23:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:23:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:23:42 INFO - 'gecko_profile': False, 10:23:42 INFO - 'gecko_profile_interval': 0, 10:23:42 INFO - 'installer_path': 'installer.exe', 10:23:42 INFO - 'log_level': 'info', 10:23:42 INFO - 'log_name': 'talos', 10:23:42 INFO - 'log_to_console': True, 10:23:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:23:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:23:42 INFO - 'opt_config_files': (), 10:23:42 INFO - 'pip_index': False, 10:23:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:23:42 INFO - 'cmd': ('bash', 10:23:42 INFO - '-c', 10:23:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:23:42 INFO - 'enabled': True, 10:23:42 INFO - 'halt_on_failure': False, 10:23:42 INFO - 'name': 'check_screen_resolution'},), 10:23:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:23:42 INFO - 'cmd': ('bash', 10:23:42 INFO - '-c', 10:23:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:23:42 INFO - 'enabled': True, 10:23:42 INFO - 'halt_on_failure': False, 10:23:42 INFO - 'name': 'check_screen_resolution'},), 10:23:42 INFO - 'run_cmd_checks_enabled': True, 10:23:42 INFO - 'suite': 'dromaeojs', 10:23:42 INFO - 'system_bits': '32', 10:23:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:23:42 INFO - 'title': 't-yosemite-r7-0344', 10:23:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:23:42 INFO - 'use_talos_json': True, 10:23:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:23:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:23:42 INFO - 'work_dir': 'build'} 10:23:42 INFO - [mozharness: 2017-04-21 17:23:42.736061Z] Running clobber step. 10:23:42 INFO - Running pre-action listener: _resource_record_pre_action 10:23:42 INFO - Running main action method: clobber 10:23:42 INFO - rmtree: /builds/slave/test/build 10:23:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:23:45 INFO - Running post-action listener: _resource_record_post_action 10:23:45 INFO - [mozharness: 2017-04-21 17:23:45.112911Z] Finished clobber step (success) 10:23:45 INFO - [mozharness: 2017-04-21 17:23:45.113094Z] Running read-buildbot-config step. 10:23:45 INFO - Running pre-action listener: _resource_record_pre_action 10:23:45 INFO - Running main action method: read_buildbot_config 10:23:45 INFO - Using buildbot properties: 10:23:45 INFO - { 10:23:45 INFO - "project": "", 10:23:45 INFO - "product": "firefox", 10:23:45 INFO - "script_repo_revision": "production", 10:23:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:23:45 INFO - "repository": "", 10:23:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:23:45 INFO - "buildid": "20170421072927", 10:23:45 INFO - "pgo_build": "False", 10:23:45 INFO - "basedir": "/builds/slave/test", 10:23:45 INFO - "buildnumber": 15, 10:23:45 INFO - "slavename": "t-yosemite-r7-0344", 10:23:45 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:23:45 INFO - "platform": "yosemite_r7", 10:23:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:23:45 INFO - "branch": "mozilla-beta", 10:23:45 INFO - "repo_path": "releases/mozilla-beta", 10:23:45 INFO - "revision": "ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e", 10:23:45 INFO - "stage_platform": "macosx64", 10:23:45 INFO - "builduid": "8c567a83b73d46fd89e6e21d15541005", 10:23:45 INFO - "slavebuilddir": "test" 10:23:45 INFO - } 10:23:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:23:45 INFO - Running post-action listener: _resource_record_post_action 10:23:45 INFO - [mozharness: 2017-04-21 17:23:45.117305Z] Finished read-buildbot-config step (success) 10:23:45 INFO - [mozharness: 2017-04-21 17:23:45.117528Z] Running download-and-extract step. 10:23:45 INFO - Running pre-action listener: _resource_record_pre_action 10:23:45 INFO - Running main action method: download_and_extract 10:23:45 INFO - mkdir: /builds/slave/test/build/tests 10:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:45 INFO - trying https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:23:45 INFO - Downloading https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:23:46 INFO - Downloaded 1165 bytes. 10:23:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:23:46 INFO - Using the following test package requirements: 10:23:46 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:23:46 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:23:46 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:23:46 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:23:46 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:23:46 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:23:46 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:23:46 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:23:46 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:23:46 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:23:46 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:23:46 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:23:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:23:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:23:46 INFO - Fetch https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:23:47 INFO - Expected file size: 51223402 10:23:47 INFO - Obtained file size: 51223402 10:24:03 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:24:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:24:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:24:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:24:05 INFO - Expected file size: 51223402 10:24:05 INFO - Obtained file size: 51223402 10:24:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:24:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:24:20 INFO - Fetch https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:24:21 INFO - Expected file size: 14404424 10:24:21 INFO - Obtained file size: 14404424 10:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:22 INFO - trying https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:24:22 INFO - Downloading https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:24:23 INFO - Downloaded 59545707 bytes. 10:24:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:24:23 INFO - mkdir: /builds/slave/test/properties 10:24:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:24:23 INFO - Writing to file /builds/slave/test/properties/build_url 10:24:23 INFO - Contents: 10:24:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:24:24 INFO - Running post-action listener: _resource_record_post_action 10:24:24 INFO - Running post-action listener: set_extra_try_arguments 10:24:24 INFO - [mozharness: 2017-04-21 17:24:24.625298Z] Finished download-and-extract step (success) 10:24:24 INFO - [mozharness: 2017-04-21 17:24:24.625403Z] Running populate-webroot step. 10:24:24 INFO - Running pre-action listener: _resource_record_pre_action 10:24:24 INFO - Running main action method: populate_webroot 10:24:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:24:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:24:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:24:24 INFO - '--tppagecycles', 10:24:24 INFO - '7'], 10:24:24 INFO - 'tests': ['tsvgm']}}, 10:24:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:24:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:24:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:24:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:24:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['damp', 'tps']}, 10:24:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'tests': ['damp', 'tps']}, 10:24:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['dromaeo_dom']}, 10:24:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:24:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['basic_compositor_video']}, 10:24:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:24:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['a11yr', 10:24:24 INFO - 'ts_paint', 10:24:24 INFO - 'tpaint', 10:24:24 INFO - 'sessionrestore', 10:24:24 INFO - 'sessionrestore_no_auto_restore', 10:24:24 INFO - 'tabpaint']}, 10:24:24 INFO - 'other-e10s': {'tests': ['a11yr', 10:24:24 INFO - 'ts_paint', 10:24:24 INFO - 'tpaint', 10:24:24 INFO - 'sessionrestore', 10:24:24 INFO - 'sessionrestore_no_auto_restore', 10:24:24 INFO - 'tabpaint']}, 10:24:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:24:24 INFO - 'ts_paint', 10:24:24 INFO - 'tpaint', 10:24:24 INFO - 'sessionrestore', 10:24:24 INFO - 'sessionrestore_no_auto_restore', 10:24:24 INFO - 'tabpaint']}, 10:24:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:24:24 INFO - 'ts_paint', 10:24:24 INFO - 'tpaint', 10:24:24 INFO - 'sessionrestore', 10:24:24 INFO - 'sessionrestore_no_auto_restore', 10:24:24 INFO - 'tabpaint']}, 10:24:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['a11yr', 10:24:24 INFO - 'ts_paint', 10:24:24 INFO - 'tpaint', 10:24:24 INFO - 'sessionrestore', 10:24:24 INFO - 'sessionrestore_no_auto_restore', 10:24:24 INFO - 'tabpaint']}, 10:24:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['a11yr', 10:24:24 INFO - 'ts_paint', 10:24:24 INFO - 'tpaint', 10:24:24 INFO - 'sessionrestore', 10:24:24 INFO - 'sessionrestore_no_auto_restore', 10:24:24 INFO - 'tabpaint']}, 10:24:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['tsvgx', 10:24:24 INFO - 'tsvgr_opacity', 10:24:24 INFO - 'tart', 10:24:24 INFO - 'tscrollx', 10:24:24 INFO - 'cart', 10:24:24 INFO - 'tsvg_static']}, 10:24:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:24:24 INFO - 'tsvgr_opacity', 10:24:24 INFO - 'tart', 10:24:24 INFO - 'tscrollx', 10:24:24 INFO - 'cart', 10:24:24 INFO - 'tsvg_static']}, 10:24:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'talos_options': ['--disable-e10s'], 10:24:24 INFO - 'tests': ['tp5o']}, 10:24:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:24:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'talos_options': ['--disable-e10s', 10:24:24 INFO - '--xperf_path', 10:24:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:24 INFO - 'tests': ['tp5n']}, 10:24:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:24:24 INFO - 'talos_options': ['--xperf_path', 10:24:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:24 INFO - 'tests': ['tp5n']}}, 10:24:24 INFO - 'talos.zip': {'path': '', 10:24:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:24:24 INFO - Running post-action listener: _resource_record_post_action 10:24:24 INFO - [mozharness: 2017-04-21 17:24:24.643748Z] Finished populate-webroot step (success) 10:24:24 INFO - [mozharness: 2017-04-21 17:24:24.643879Z] Running create-virtualenv step. 10:24:24 INFO - Running pre-action listener: _resource_record_pre_action 10:24:24 INFO - Running main action method: create_virtualenv 10:24:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:24:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:24:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:24:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:24:24 INFO - Using real prefix '/tools/python27' 10:24:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:24:25 INFO - Installing distribute.............................................................................................................................................................................................done. 10:24:28 INFO - Installing pip.................done. 10:24:28 INFO - Return code: 0 10:24:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:24:28 INFO - Reading from file tmpfile_stdout 10:24:28 INFO - Output received: 10:24:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:24:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:28 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:28 INFO - 'HOME': '/Users/cltbld', 10:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:28 INFO - 'LOGNAME': 'cltbld', 10:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:28 INFO - 'MOZ_NO_REMOTE': '1', 10:24:28 INFO - 'NO_EM_RESTART': '1', 10:24:28 INFO - 'PAGER': '/bin/cat', 10:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:28 INFO - 'PWD': '/builds/slave/test', 10:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:28 INFO - 'SHELL': '/bin/bash', 10:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:28 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:28 INFO - 'USER': 'cltbld', 10:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:28 INFO - 'XPC_FLAGS': '0x0', 10:24:28 INFO - 'XPC_SERVICE_NAME': '0', 10:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:24:28 INFO - Cleaning up... 10:24:28 INFO - Return code: 0 10:24:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:28 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:28 INFO - 'HOME': '/Users/cltbld', 10:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:28 INFO - 'LOGNAME': 'cltbld', 10:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:28 INFO - 'MOZ_NO_REMOTE': '1', 10:24:28 INFO - 'NO_EM_RESTART': '1', 10:24:28 INFO - 'PAGER': '/bin/cat', 10:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:28 INFO - 'PWD': '/builds/slave/test', 10:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:28 INFO - 'SHELL': '/bin/bash', 10:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:28 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:28 INFO - 'USER': 'cltbld', 10:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:28 INFO - 'XPC_FLAGS': '0x0', 10:24:28 INFO - 'XPC_SERVICE_NAME': '0', 10:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:29 INFO - Downloading/unpacking psutil>=3.1.1 10:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:32 INFO - Installing collected packages: psutil 10:24:32 INFO - Running setup.py install for psutil 10:24:32 INFO - building 'psutil._psutil_osx' extension 10:24:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:24:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:24:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:24:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:24:33 INFO - building 'psutil._psutil_posix' extension 10:24:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:24:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:24:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:24:33 INFO - ^ 10:24:33 INFO - 1 warning generated. 10:24:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:33 INFO - Successfully installed psutil 10:24:33 INFO - Cleaning up... 10:24:33 INFO - Return code: 0 10:24:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:33 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:33 INFO - 'HOME': '/Users/cltbld', 10:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:33 INFO - 'LOGNAME': 'cltbld', 10:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:33 INFO - 'MOZ_NO_REMOTE': '1', 10:24:33 INFO - 'NO_EM_RESTART': '1', 10:24:33 INFO - 'PAGER': '/bin/cat', 10:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:33 INFO - 'PWD': '/builds/slave/test', 10:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:33 INFO - 'SHELL': '/bin/bash', 10:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:33 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:33 INFO - 'USER': 'cltbld', 10:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:33 INFO - 'XPC_FLAGS': '0x0', 10:24:33 INFO - 'XPC_SERVICE_NAME': '0', 10:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:24:36 INFO - Installing collected packages: mozsystemmonitor 10:24:36 INFO - Running setup.py install for mozsystemmonitor 10:24:36 INFO - Successfully installed mozsystemmonitor 10:24:36 INFO - Cleaning up... 10:24:36 INFO - Return code: 0 10:24:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:37 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:37 INFO - 'HOME': '/Users/cltbld', 10:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:37 INFO - 'LOGNAME': 'cltbld', 10:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:37 INFO - 'MOZ_NO_REMOTE': '1', 10:24:37 INFO - 'NO_EM_RESTART': '1', 10:24:37 INFO - 'PAGER': '/bin/cat', 10:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:37 INFO - 'PWD': '/builds/slave/test', 10:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:37 INFO - 'SHELL': '/bin/bash', 10:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:37 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:37 INFO - 'USER': 'cltbld', 10:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:37 INFO - 'XPC_FLAGS': '0x0', 10:24:37 INFO - 'XPC_SERVICE_NAME': '0', 10:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:37 INFO - Downloading/unpacking jsonschema==2.5.1 10:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:24:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:24:41 INFO - warning: no files found matching '*.txt' 10:24:41 INFO - no previously-included directories found matching 'build' 10:24:41 INFO - no previously-included directories found matching 'dist' 10:24:41 INFO - no previously-included directories found matching '.git*' 10:24:41 INFO - Installing collected packages: jsonschema, functools32 10:24:41 INFO - Running setup.py install for functools32 10:24:41 INFO - warning: no files found matching '*.txt' 10:24:41 INFO - no previously-included directories found matching 'build' 10:24:41 INFO - no previously-included directories found matching 'dist' 10:24:41 INFO - no previously-included directories found matching '.git*' 10:24:41 INFO - Successfully installed jsonschema functools32 10:24:41 INFO - Cleaning up... 10:24:41 INFO - Return code: 0 10:24:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:41 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:41 INFO - 'HOME': '/Users/cltbld', 10:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:41 INFO - 'LOGNAME': 'cltbld', 10:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:41 INFO - 'MOZ_NO_REMOTE': '1', 10:24:41 INFO - 'NO_EM_RESTART': '1', 10:24:41 INFO - 'PAGER': '/bin/cat', 10:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:41 INFO - 'PWD': '/builds/slave/test', 10:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:41 INFO - 'SHELL': '/bin/bash', 10:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:41 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:41 INFO - 'USER': 'cltbld', 10:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:41 INFO - 'XPC_FLAGS': '0x0', 10:24:41 INFO - 'XPC_SERVICE_NAME': '0', 10:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:24:41 INFO - Cleaning up... 10:24:41 INFO - Return code: 0 10:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:41 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:41 INFO - 'HOME': '/Users/cltbld', 10:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:41 INFO - 'LOGNAME': 'cltbld', 10:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:41 INFO - 'MOZ_NO_REMOTE': '1', 10:24:41 INFO - 'NO_EM_RESTART': '1', 10:24:41 INFO - 'PAGER': '/bin/cat', 10:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:41 INFO - 'PWD': '/builds/slave/test', 10:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:41 INFO - 'SHELL': '/bin/bash', 10:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:41 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:41 INFO - 'USER': 'cltbld', 10:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:41 INFO - 'XPC_FLAGS': '0x0', 10:24:41 INFO - 'XPC_SERVICE_NAME': '0', 10:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:24:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:24: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 10:24: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 10:24: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 10:24: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 10:24: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 10:24: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 10:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:24:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:46 INFO - Downloading docopt-0.6.1.tar.gz 10:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:24:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:24:46 INFO - Running setup.py install for blobuploader 10:24:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:24:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:24:46 INFO - Running setup.py install for requests 10:24:46 INFO - Running setup.py install for docopt 10:24:46 INFO - Successfully installed blobuploader requests docopt 10:24:46 INFO - Cleaning up... 10:24:47 INFO - Return code: 0 10:24:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24: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')]} 10:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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')]} 10:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:47 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:47 INFO - 'HOME': '/Users/cltbld', 10:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:47 INFO - 'LOGNAME': 'cltbld', 10:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:47 INFO - 'MOZ_NO_REMOTE': '1', 10:24:47 INFO - 'NO_EM_RESTART': '1', 10:24:47 INFO - 'PAGER': '/bin/cat', 10:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:47 INFO - 'PWD': '/builds/slave/test', 10:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:47 INFO - 'SHELL': '/bin/bash', 10:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:47 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:47 INFO - 'USER': 'cltbld', 10:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:47 INFO - 'XPC_FLAGS': '0x0', 10:24:47 INFO - 'XPC_SERVICE_NAME': '0', 10:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Z0vB3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-pmLt0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Ny8t8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ZujmlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-G6ecAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-4DbqF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:24:47 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-aGBxEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-wc_6sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-NuPlef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-zhieq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-zlnrN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-uVFr5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-HD0QC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-hJn8sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-MSkLBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-GeNH1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:24:48 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-TRCEiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:24:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:24:49 INFO - Running setup.py install for manifestparser 10:24:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:24:49 INFO - Running setup.py install for mozcrash 10:24:49 INFO - Running setup.py install for mozdebug 10:24:49 INFO - Running setup.py install for mozdevice 10:24:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:24:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:24:49 INFO - Running setup.py install for mozfile 10:24:49 INFO - Running setup.py install for mozhttpd 10:24:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:24:49 INFO - Running setup.py install for mozinfo 10:24:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Running setup.py install for mozInstall 10:24:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Running setup.py install for mozleak 10:24:50 INFO - Running setup.py install for mozlog 10:24:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Running setup.py install for moznetwork 10:24:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:24:50 INFO - Running setup.py install for mozprocess 10:24:50 INFO - Running setup.py install for mozprofile 10:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:24:51 INFO - Running setup.py install for mozrunner 10:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:24:51 INFO - Running setup.py install for mozscreenshot 10:24:51 INFO - Running setup.py install for moztest 10:24:51 INFO - Running setup.py install for mozversion 10:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:24:51 INFO - Cleaning up... 10:24:51 INFO - Return code: 0 10:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24: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')]} 10:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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')]} 10:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:51 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:51 INFO - 'HOME': '/Users/cltbld', 10:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:51 INFO - 'LOGNAME': 'cltbld', 10:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:51 INFO - 'MOZ_NO_REMOTE': '1', 10:24:51 INFO - 'NO_EM_RESTART': '1', 10:24:51 INFO - 'PAGER': '/bin/cat', 10:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:51 INFO - 'PWD': '/builds/slave/test', 10:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:51 INFO - 'SHELL': '/bin/bash', 10:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:51 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:51 INFO - 'USER': 'cltbld', 10:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:51 INFO - 'XPC_FLAGS': '0x0', 10:24:51 INFO - 'XPC_SERVICE_NAME': '0', 10:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:24:51 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-f4SDuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-X3YQDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-_XT2AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-J5T11F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-K_KabP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Tuk6hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-gZInXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-qSvLLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-eeb3L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:24:52 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-16izO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-zyqELv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-2jnN3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-6f2tKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-0IRg7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-IAKpuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-fQg8Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:24:53 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-AgekCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:56 INFO - Downloading blessings-1.6.tar.gz 10:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:24:56 INFO - Installing collected packages: blessings 10:24:56 INFO - Running setup.py install for blessings 10:24:56 INFO - Successfully installed blessings 10:24:56 INFO - Cleaning up... 10:24:56 INFO - Return code: 0 10:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:24:56 INFO - Reading from file tmpfile_stdout 10:24:56 INFO - Current package versions: 10:24:56 INFO - blessings == 1.6 10:24:56 INFO - blobuploader == 1.2.4 10:24:56 INFO - docopt == 0.6.1 10:24:56 INFO - functools32 == 3.2.3-2 10:24:56 INFO - jsonschema == 2.5.1 10:24:56 INFO - manifestparser == 1.1 10:24:56 INFO - mozInstall == 1.12 10:24:56 INFO - mozcrash == 1.0 10:24:56 INFO - mozdebug == 0.1 10:24:56 INFO - mozdevice == 0.49 10:24:56 INFO - mozfile == 1.2 10:24:56 INFO - mozhttpd == 0.7 10:24:56 INFO - mozinfo == 0.9 10:24:56 INFO - mozleak == 0.1 10:24:56 INFO - mozlog == 3.4 10:24:56 INFO - moznetwork == 0.27 10:24:56 INFO - mozprocess == 0.25 10:24:56 INFO - mozprofile == 0.28 10:24:56 INFO - mozrunner == 6.13 10:24:56 INFO - mozscreenshot == 0.1 10:24:56 INFO - mozsystemmonitor == 0.3 10:24:56 INFO - moztest == 0.8 10:24:56 INFO - mozversion == 1.4 10:24:56 INFO - psutil == 3.1.1 10:24:56 INFO - requests == 1.2.3 10:24:56 INFO - wsgiref == 0.1.2 10:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:56 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:56 INFO - 'HOME': '/Users/cltbld', 10:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:56 INFO - 'LOGNAME': 'cltbld', 10:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:56 INFO - 'MOZ_NO_REMOTE': '1', 10:24:56 INFO - 'NO_EM_RESTART': '1', 10:24:56 INFO - 'PAGER': '/bin/cat', 10:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:56 INFO - 'PWD': '/builds/slave/test', 10:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:56 INFO - 'SHELL': '/bin/bash', 10:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:56 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:56 INFO - 'USER': 'cltbld', 10:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:56 INFO - 'XPC_FLAGS': '0x0', 10:24:56 INFO - 'XPC_SERVICE_NAME': '0', 10:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:24:57 INFO - Cleaning up... 10:24:57 INFO - Return code: 0 10:24:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:24: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')]} 10:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24: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')]} 10:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:57 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 0x102d00b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d03768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f14ab3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, '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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:57 INFO - 'HOME': '/Users/cltbld', 10:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:57 INFO - 'LOGNAME': 'cltbld', 10:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:57 INFO - 'MOZ_NO_REMOTE': '1', 10:24:57 INFO - 'NO_EM_RESTART': '1', 10:24:57 INFO - 'PAGER': '/bin/cat', 10:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:57 INFO - 'PWD': '/builds/slave/test', 10:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:57 INFO - 'SHELL': '/bin/bash', 10:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:24:57 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:57 INFO - 'USER': 'cltbld', 10:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:57 INFO - 'XPC_FLAGS': '0x0', 10:24:57 INFO - 'XPC_SERVICE_NAME': '0', 10:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:24:57 INFO - Cleaning up... 10:24:57 INFO - Return code: 0 10:24:57 INFO - Running post-action listener: _resource_record_post_action 10:24:57 INFO - Running post-action listener: _start_resource_monitoring 10:24:57 INFO - Starting resource monitoring. 10:24:57 INFO - [mozharness: 2017-04-21 17:24:57.517966Z] Finished create-virtualenv step (success) 10:24:57 INFO - [mozharness: 2017-04-21 17:24:57.518995Z] Running install step. 10:24:57 INFO - Running pre-action listener: _resource_record_pre_action 10:24:57 INFO - Running main action method: install 10:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:24:57 INFO - Reading from file tmpfile_stdout 10:24:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:24:57 INFO - Reading from file tmpfile_stdout 10:24:57 INFO - Output received: 10:24:57 INFO - Usage: mozinstall [options] installer 10:24:57 INFO - Options: 10:24:57 INFO - -h, --help show this help message and exit 10:24:57 INFO - -d DEST, --destination=DEST 10:24:57 INFO - Directory to install application into. [default: 10:24:57 INFO - "/builds/slave/test"] 10:24:57 INFO - --app=APP Application being installed. [default: firefox] 10:24:57 INFO - mkdir: /builds/slave/test/build/application 10:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:25:12 INFO - Reading from file tmpfile_stdout 10:25:12 INFO - Output received: 10:25:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:25:12 INFO - Running post-action listener: _resource_record_post_action 10:25:12 INFO - [mozharness: 2017-04-21 17:25:12.555578Z] Finished install step (success) 10:25:12 INFO - [mozharness: 2017-04-21 17:25:12.555708Z] Running run-tests step. 10:25:12 INFO - Running pre-action listener: _resource_record_pre_action 10:25:12 INFO - Running main action method: run_tests 10:25:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:25:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:25:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:25:12 INFO - 2017-04-21 10:25:12.570 screenresolution[1627:7440] starting screenresolution argv=screenresolution get 10:25:12 INFO - 2017-04-21 10:25:12.572 screenresolution[1627:7440] Display 0: 1600x1200x32@60 10:25:12 INFO - 2017-04-21 10:25:12.578 screenresolution[1628:7442] starting screenresolution argv=screenresolution list 10:25:12 INFO - Available Modes on Display 0 10:25:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:25:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:25:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:25:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:25:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:25:12 INFO - Intel Iris: 10:25:12 INFO - Chipset Model: Intel Iris 10:25:12 INFO - Type: GPU 10:25:12 INFO - Bus: Built-In 10:25:12 INFO - VRAM (Dynamic, Max): 1536 MB 10:25:12 INFO - Vendor: Intel (0x8086) 10:25:12 INFO - Device ID: 0x0a2e 10:25:12 INFO - Revision ID: 0x0009 10:25:12 INFO - Displays: 10:25:12 INFO - Display: 10:25:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:25:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:25:12 INFO - Display Serial Number: 1600x1200 60 10:25:12 INFO - Main Display: Yes 10:25:12 INFO - Mirror: Off 10:25:12 INFO - Online: Yes 10:25:12 INFO - Rotation: Supported 10:25:12 INFO - Return code: 0 10:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:25:12 INFO - Python 2.7.3 10:25:12 INFO - Return code: 0 10:25:12 INFO - grabbing minidump binary from tooltool 10:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:12 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 0x102aded30>, '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 0x102a05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ad3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:25:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:25:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:25:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:25:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:25:12 INFO - Return code: 0 10:25:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:25:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:25:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:25:12 INFO - ENV: RUST_BACKTRACE is now 1 10:25:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:25:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:25:12 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/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:25:12 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/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:25:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y4xHxT5aYj/Render', 10:25:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:25:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:25:12 INFO - 'HOME': '/Users/cltbld', 10:25:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:25:12 INFO - 'LOGNAME': 'cltbld', 10:25:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:25:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:12 INFO - 'MOZ_NO_REMOTE': '1', 10:25:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:25:12 INFO - 'NO_EM_RESTART': '1', 10:25:12 INFO - 'PAGER': '/bin/cat', 10:25:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:12 INFO - 'PWD': '/builds/slave/test', 10:25:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:25:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:25:12 INFO - 'RUST_BACKTRACE': '1', 10:25:12 INFO - 'SHELL': '/bin/bash', 10:25:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aR91RM9WO8/Listeners', 10:25:12 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 10:25:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:25:12 INFO - 'USER': 'cltbld', 10:25:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:25:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:12 INFO - 'XPC_FLAGS': '0x0', 10:25:12 INFO - 'XPC_SERVICE_NAME': '0', 10:25:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:25:12 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/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:25:13 INFO - mozversion application_buildid: 20170421072927 10:25:13 INFO - mozversion application_changeset: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e 10:25:13 INFO - mozversion application_display_name: Firefox 10:25:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:25:13 INFO - mozversion application_name: Firefox 10:25:13 INFO - mozversion application_remotingname: firefox 10:25:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:25:13 INFO - mozversion application_vendor: Mozilla 10:25:13 INFO - mozversion application_version: 54.0 10:25:13 INFO - mozversion platform_buildid: 20170421072927 10:25:13 INFO - mozversion platform_changeset: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e 10:25:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:25:13 INFO - mozversion platform_version: 54.0 10:25:13 INFO - using testdate: 1492795513 10:25:13 INFO - actual date: 1492795513 10:25:13 INFO - starting webserver on 'localhost:49249' 10:25:13 INFO - SUITE-START | Running 2 tests 10:25:13 INFO - TEST-START | dromaeo_css 10:25:13 INFO - operating with platform_type : mac_ 10:25:13 INFO - Initialising browser for dromaeo_css test... 10:25:13 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp16zOPA/profile http://localhost:49249/getInfo.html) 10:25:15 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 10:25:15 INFO - PROCESS | 1638 | colorDepth:24 10:25:15 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 10:25:15 INFO - PROCESS | 1638 | __metrics 10:25:15 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:25:15 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:16 INFO - TEST-INFO | 1638: exit 0 10:25:16 INFO - Browser initialized. 10:25:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:25:16 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmp16zOPA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:28 INFO - PROCESS | 1641 | RSS: Main: 165490688 10:25:28 INFO - PROCESS | 1641 | 10:28:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 10:28:33 INFO - PROCESS | 1641 | RSS: Main: 298074112 10:28:33 INFO - PROCESS | 1641 | 10:31:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 10:31:37 INFO - PROCESS | 1641 | RSS: Main: 304877568 10:31:37 INFO - PROCESS | 1641 | 10:34:39 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 10:34:40 INFO - PROCESS | 1641 | RSS: Main: 284160000 10:34:40 INFO - PROCESS | 1641 | 10:37:42 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 10:37:43 INFO - PROCESS | 1641 | RSS: Main: 269197312 10:37:43 INFO - PROCESS | 1641 | 10:40:46 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 10:40:47 INFO - PROCESS | 1641 | RSS: Main: 273186816 10:40:47 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:43:50 INFO - PROCESS | 1641 | RSS: Main: 495562752 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | __start_tp_report 10:43:50 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 10:43:50 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 10:43:50 INFO - PROCESS | 1641 | |i|pagename|runs| 10:43:50 INFO - PROCESS | 1641 | |0;dojo.html;3566.5185199998;3571.785692858429;3603.0812142903555;3606.350856845767;3648.343298206322;6206.038064100072;6219.253689557254;6241.344658810827;6245.56281060326;6303.6532990685555;6208.534359923013;6240.563160578761;6266.592671476351;6267.811965641038;6275.68621568922;5569.164625306216;5592.049351610226;5607.607467477278;5640.943590564083;5707.258056452655;5469.316335458067;5480.7533660985355;5512.228288039678;5566.693831839248;5716.3426205986425;5571.247881535981;5579.972100139494;5592.3009623797025;5592.328920529521;5609.411011843738;5607.990561698893;5651.660900345972;5654.067078931971;5654.547636189095;5659.151127330892;5412.404635490093;5466.753996070186;5583.832485025456;5589.608727389084;5657.773689052433;6102.176206212149;6108.175396321484;6121.081837724332;6124.050772130327;6129.111278864584;6355.682215889234;6405.167328247345;6439.903401448982;6505.121808555879;6509.544331896769;4750.691205071694;6615.569987950816;6618.834529136762;6634.734610615569;6636.137302150738;6333.651649159295;6340.651264180468;6354.332795056545;6356.14192084072;6363.140975968277;6391.840203994844;6439.388258115471;6689.866202675919;6729.596224226562;6808.4212841908;5373.462653734673;6441.967790161113;6449.3873082057125;6460;6463.838404039842;6538.117354157223;6582.80251592453;6601.933980660228;6605.768798092044;6607.570507917067;6305.621662700161;6349.841253968595;6387.073874288295;6484.740610375627;6507.934920650733;6401.615903045739;6490.902636460457;6510.837229069217;6517.348265173445;6523.6738163092605;5306.257124002643;5332.9733351333;5333.066713325153;5343.65266257692;5370.677759334452;4609.423822022247;4691.437027556715;4739.075880203327;4757.238841785298;4769.499202583679;6227.408396202444;6323.399277068671;6327.905081423783;6355.650439225795;6372.044193371032;6535;6537.1501704778075;6539.607623542507;6541.5093867960095;6551.80344589663;6299.1811064562235;6332.651704156224;6363.268224154189;6368.172137622172;6392.26488953767;5631.1271752878365;5661.575381846295;5719.742611582489;5725.656460612377;5732.369439361667;6625.469962403093;6677.499187560855;6681.899771503528;6698.7990360288295;6852.691628876612;6549.7380104795275;6572.605643661395;6579.934200658124;6581.407673309425;6588.637624930675;6920.9307906920285;6943.583384996917;6951.895721564079;6960.895586566105;6972.616506092214;6311.936880631135;6372.904406433814;6466.708998095191;6494.805155845333;6499;5499.285092937893;6450.709718062604;6500.057491663777;6564.737410503526;6565.113709649328;6412.39082287182;6425.389587989133;6426.228852537725;6433.228012638326;6444.097826304415;5019.974900125622;6391.32891046452;6413.935860641521;6414.390632889868;6465.935340646533;6184.845378865564;6297.118403423616;6346.555741098264;6356.459700925473;6367.649779261999;5440.591955603425;6368.968155159195;6415.71129299192;6416.32628573993;6417.197850268716;6291.496680265476;6345.841353966188;6346.174997250512;6346.333634968447;6346.555741098079 10:43:50 INFO - PROCESS | 1641 | |1;ext.html;738.3133685672326;789.7078081109987;837.5267973594916;911.977200569986;921.2123634292675;29435.852820735894;39841.4023789643;40352.59647403525;43776.56223437765;43990.780046099724;42681.14637707252;42773.786131069304;42810.50163244287;42826;42870.92822679435;7883.566403847786;8030.5181689098845;9529;9692.95153524235;9697.3696709714;7984.441089123764;8061.0326760788785;8062.879056814123;11582.362970036645;11732.648020559354;11703.53185872564;11754.353510556915;11793.292402455838;11813.232139910879;11862.644120676394;11762.353070581115;11762.882371176263;11772.470238839272;11785.705357366134;11806.937375636147;11468.942655286754;11509.424528773528;11514.251573647769;11524.596639117675;11556.53773849045;38741;39004.82985510439;39037.82886513409;39089.41365879486;39092.804535977135;4005.859794907193;4046.3728122141115;4074.327735923569;4095.201435720036;4112.629863312286;23475.17836875718;27492.17523474279;30341.393172136653;30669.38661226763;30748;3167.129039514129;3226.6289376721743;3288.917777055569;3422.178677117499;3423.96576034239;348473.2576337102;348781;348950;349289;349303;52912.735436322575;53232.73383633057;53412;53421.46578534243;53651.46348536543;55282.17076743852;55336.16995745067;55358.723206384515;55422;55527;14304.356303966346;14684.339204735812;14688.19214943167;14692.779608305671;14777.778333325008;12585;12587.748245035047;12589.93705031469;12592.99256059513;12603.243805371707;9449.76375590602;9618.422894626345;9733.561989710339;11778.5877494289;12173.878261217274;4785.688930219525;5455.509004189642;5472.315960504937;5480.890382192334;5494.972525137348;1151.113642495274;1171.1158075652997;1183.526589364261;1197.5628895453096;1204.3436327201696;27240.45519089607;27497.900083996417;27783.58324625132;27794.722052779616;27950;1274.5347947999098;1281.51943021367;1282.2370689439767;1321.2402868350737;1323.1002918015843;12897.032722545846;13971.371288291848;14037.438502459787;14251.714965700628;14348.49780257686;466096;466365;466593;467197;474733;42045.78977105095;46886.5311346889;51119;57230;61489.69255153785;1310.2007775257086;1477.106350657858;1506.6231751461908;1521.4522771802365;1521.7260893039359;22845.77154228503;24875;29448;31074.115735533058;31431.528527071656;46958.76520617375;47107.52892471168;47194.29208561806;47227.58317250488;47245;406016;407018;408543;409064.9093509146;409230;34801.08594027353;35287.11782205466;35332.940011799685;35432.64567354293;35587.644123558435;40544.594554054085;44837.77581112074;44958;46372;46515.069698606516;26513.60229596596;28034.71965280321;28490.002849900153;28905;29019.564706528996;27606.5859012119;27612.171634850987;28567.857160714062;28850.27874303159;29020.709792901802;36632.633673662924;37222.62777372191;37304;37316;37465.81267093647;26944;27784.583231251952;27989.86005070043;28149.577756333263;28251.2937176564;23423.76576234216;24821.87589062043;25022.62466063047;25109.497810043333;25409.61885571681 10:43:50 INFO - PROCESS | 1641 | |2;jquery.html;428.63351834181793;433.6054190686474;438.2965340628292;438.7104511022725;449.21611787430936;20922.6861597076;21452.678209826845;22888.65667014994;22916.541669166607;23028;23160.30519084426;23423.297301080995;24140.637890431615;24313.392165195877;24586.385340366498;6972.093627828388;7027.664743698707;7076.85846283074;7143.499955003152;7153.713851445936;6842.965785171067;7124.180719217278;7149.678264478111;7156.749513767019;7157.785266441989;6812.931870681279;7184.317489838483;7190.101237345332;7197.784066478014;7202.711891524333;6773.119494465713;7029.332213439715;7087.539309944863;7110.217876033632;7152;6923.723051077951;6955;6977.232504424509;6977.825554361131;6982.895256571155;26406;28054.158375248775;28203.57694634582;28538.429231415255;30272.84863575668;2962.674105848355;3031.8332491712945;3048.4512787698204;3202.327511222646;3233.8868139615;16034.75947860783;16676.999380037236;16708.83291167085;17182.828171718247;17431.128443577898;2027.432318950696;2101.8843963582;2135.6049130910833;2175.380016695234;2274.465500607356;91953.54023229908;103286;110061.62188809465;151372.2431387847;166036.33963660328;18986.71519927202;19967.400977970683;20073.799262007484;20139.295124670858;20158.89920550388;30581.929632462758;30613.234669133006;30642.387152257277;30729.846350768552;30798.384032319227;10269.845952310721;10393.792124157626;10560.313579617301;10569.312994655324;10729.731756705989;8735.126487351214;8759.34304927133;8779.517126558101;8911.955440222757;8919.241864441465;7904.762857114296;9306.302027347976;9418.29362797793;9497.192738617157;9521.857172142423;3217.7747557671205;3310.8841190558214;3899.941500877489;3906.3554513504955;3923.313420151462;786.6420778545748;793.1216352038537;797.8125140591957;810.8621534339177;922.7785331520387;21819;22398.328050158194;22628.773712262995;23888.52222955531;24907.750922490904;1082.7401423658423;1086.3916206924148;1096.660035389032;1108.1854836695022;1128.418864284894;11769.352685602204;11842.348670823016;11947.581834635746;12011.699707507381;12059.698507537207;772417;801967;802402;806492;820378.8981055176;154262;155109;156389.218053909;156596.21701891645;158022.469213577;1268.8921441677376;1289.1233960906673;1322.2925734731873;1323.4970711129708;1323.6558494791232;16217.432389866299;19640;20322;20409.591808164052;20410.18359265613;62341.37658623537;63852;63923.68038159779;64801;65994.67002664956;88133;88476;88677.55661221653;90381.54809226174;90605.54697226471;11179.329240245612;11603.36181510025;11703.180777345504;11775.52897884075;11911.225770324902;11246.606368777053;13137.277449740355;13199.34003299812;13385.263810490516;13578.38897249646;10298.279120461495;10870.728231794268;11501.597444089417;11550.711232219262;11863.703407414538;8717.956410217908;9702.805943881223;10056.533163468417;10186.643467478603;10227.181825453798;11642.301461912313;11714.355710435668;11735.061195104541;11764;12013.279203247834;11479.25384849982;11644.126690498077;11693.239939403911;11806.940965295118;11913.344766037952;9747.463889486145;11125.332480051224;11523.711907202387;11664.708382290512;11790.115741319263 10:43:50 INFO - PROCESS | 1641 | |3;mootools.html;1420.992895035525;1578.0689393257976;1613.7418013117904;1634.1665750467262;1637.8444047815453;10877.129829613632;11538.961493465597;11553.017993470565;11554.65336039919;11626.593069242579;11330.98021178096;11413.486393112309;11729.240613907918;11937.880621193786;11947.940260298708;2452.386903274186;2490.7260201377835;2498.0757119865675;2501.2371226775826;2506.0226511660376;2407.229686500312;2417.3714834143075;2460.938476538083;2472.777450029497;2474.3195621204222;2419.080749315258;2432.6351047342864;2439;2454.202384225125;2457.3242358351417;2371.0515793682493;2413.3001429585397;2429.2105065853666;2431.756824317563;2439.780419762221;2426.2478631624253;2443.8289319747623;2452.3746444656676;2457.6313552967017;2460.5447992121517;11359.261647992855;11583.420828958519;11592.594259200887;11614.76770464586;11623;5774.249347584787;5974.22335096439;5983.700814959235;5985.40145985398;5993.910091348634;3127.218195451137;3457.861685532576;3582.5163602913794;3582.802945837978;3620.818959052037;1131.349474052415;1132.179170101678;1147.2657499200434;1231.975360492785;1285.1710646632869;13923;14196.645083872985;14539.3457294422;15558;15784.210789460596;4595.310703394518;4706.95293047072;4714.033623107255;4732.171869922819;4735.857924262277;10319.94840025795;10530.894691052992;11882.28706277626;11903.404829758478;11905.345206013752;4981.352424184905;5033.924491132562;5055.6713813602;5067.847964561069;5680.68756218412;5192.3769147702515;5286.048511268009;5330.626856120112;5345.224942383333;5368.651037682538;3891.9416208756893;3898.200868821885;3923.7449565778134;3974.6025397460603;4021.1354558770004;1012.2863381316301;1021.7190272674925;1025.779457416659;1027.992567284066;1029.2692188546066;963.1524258652481;973.73709098543;1009.8131845608586;1018.6383833738915;1026.153423425662;5389.757460914268;6575.243846957565;6640.269570347258;6653.700583473756;6771.661416929134;965.280865755017;1019.8827134879584;1025.8922813104666;1069.1820757120809;1079.9298045627008;4080.4287399764057;4177.519585247735;4244.893877653021;4246.320588705854;4343.847965321199;13377.598672039854;13921.373538190806;13947.58157255284;13959.371828267753;13965.650858728613;13530.729385412236;13652.880169936274;13839.861601384058;13998.580042598738;14023.368948397347;10326;10389.94805025985;10394.376337419779;10413.739656508647;10455.424951627581;6440.355964403522;6558.442532384801;6693.665316734241;6725.125733654593;6757.797266082025;12112.84927931845;12296.323702196465;12360.567380141652;12419;12454.190477618926;11140.888591113986;11648.650540483799;12470.438830252479;12561.623151305475;13112.934435327763;8506.659733610833;8654;8777;8789.516576588348;8790.340724445565;10539.736506587396;10608.416537090225;10625.25623206399;10716.946415267874;10788.568457261936;8436.957815210884;8443.197896199852;8499.617517211864;8500.91499085026;8536.231739143506;8341.165883411853;8370.246677799027;8549.529775862138;8561.1866872647;8580.742577722678;7810.984572005603;8022.679092836222;8202.425830191829;8329.708460203863;8348.540830254395;4982.7508624569355;5835.4748072673665;5896.7936122235515;6027.156198132177;6049.576529642883;5086.898262034812;6060.424259695322;6104.053871649901;6195.969020155051;6203.534734894811 10:43:50 INFO - PROCESS | 1641 | |4;prototype.html;394.9052227465408;395.79814294709706;399.056232011293;400.5472824254923;401.63049994005513;4557.270836666125;5220.68675879447;5324.334458192726;5372;5386.245925570418;4668.18306796311;4874.8537543873745;5045.016221836743;5167.250748641454;5250.327208784176;3670.7981061041633;3707.3697471429923;4021.7385869918435;4135.250058710953;4185.769782661952;3726.88819335419;4197.16056788642;4202.348635961431;4227.837344730208;4249.362595610668;3909.863154789583;4158.750474971512;4186.299836605388;4197.8530751423705;4210.97894510527;3357.2949680567112;3468.959312206328;4119.754733670157;4121.91756164878;4148.709590328663;3651.8958884947583;3672.155404257009;3673.5591728992426;3689.2990331836863;3708.479523395395;4597.310403439477;4619.584237418615;4680.970186558951;4744.572988431023;4858.344123543312;4081.8979525511804;4547.53863978109;4738.976305118453;4832.710037397732;4909.459959404463;5178.556260087038;5568.9443105568835;5583.637063590853;5587.379659898625;5594.042085270164;3511.348931556684;4011.97994010031;4073.6130067643526;4090.1819636072905;4112.300908845504;5607.448610882079;5704.058830292996;5777.537796976232;5851.882962340729;5889.882202355929;3500;3725.906852328659;3968.543617483969;4120.134771697917;4162.313218319004;4241.4698162729655;4302.505211900609;4303.870883873489;4308.655307575386;4309.332053531708;3918.2359439908946;4501.234790085693;4595.2188128018315;4788.281757736368;4894;4743.264793956942;5023.196288593807;5626.634268772516;5653.614864358176;5670.043834876961;1696.4910526842145;1715;1721.8278172182681;1740.26908698347;1743.4943866278636;1239.9938000310121;1281.6731733407921;1315.1977293850744;1358.0444160408979;1381.9723605528034;4568.931466028012;4697.107549565571;5040.420351659606;5256.579473642099;5309.469202980053;5081.720505372166;5185.9740701297005;5256.423073078061;5722.685252311163;5726.513246374105;4328.458942632171;4748.477667456577;4811.518848115161;4926.842192084857;5153;2591.9092831751177;2613.6079588061943;2980;2996.6853480384248;2997.5461900978007;5135.177012160704;5533.22534845122;5540.473655002768;5931.606072572942;6082.939170608237;5041.033996741274;5144.321809905935;5306.602004849652;5760.308762948389;5994.1608174855555;4997.625178111656;5920.911186332209;5938.703064846827;6116.785912493041;6126.295476020226;4938.839142948587;4944.357233559758;5029.798808047637;5089.949100508948;5112.488751125006;4541.500434952087;5658.585353661585;5744.454276843693;5759.337676167127;5802;5289.312389389354;6082;6108.419700128481;6130.938690613215;6137.294211165595;4470.329450582439;4915.729634870117;4954.8761280968265;4954.950450495449;4963.478834722302;4988.825391111293;5130.384353877558;5627.7467513961155;5816.621919575214;5822.4759771619065;5000;5610;5633.943660563342;5654.7455364509515;5725.570582206435;5341.985022845647;5491.533219676372;5598.608097433141;5649.830505084854;5727.341355744143;5171.715555644325;5373.2746079278795;5434.212039254365;5479.0959491683425;5604.99110160175;4938.876528086683;5124.564412024871;5133.820316289061;5152.871178220575;5644.6330988485615;5124.692518448905;5485.698286594116;5505.807296744755;5544.500994910478;5548.667079975215 10:43:50 INFO - PROCESS | 1641 | |5;yui.html;763.4159867701213;785.6660919109377;801.4229754576706;871.2724874729602;884.9823003539931;16074.196290185488;17657.381991630296;17657.735133973;17705.46883593491;17737.37919172829;16058;16182.919085404586;16183.595410114753;16234.431794887181;16298.755518667229;1000.5791775678535;1017.2574020964663;1029.907308342249;1051.6634676903393;1053.8629978102836;1030.469308306219;1034.3380236648552;1035.3425574760006;1036.6164519127894;1037.2169012395632;1079.3254216114929;1079.3362082319356;1081.967540973772;1083.0956151613373;1086.6414083352515;1079.0773888325448;1080.864891888514;1081.9729506762314;1083.2363183955292;1083.4961742789562;806.0166596752011;807.5195258821051;808.3735105293445;809.2676128104075;813.3493205435627;16642.417515386904;17277.39529116475;17463.738043929352;17573.7363939541;17882.28470861164;14619.342129604192;14842.480513181987;14930.925345373204;15013;15095.943283970126;11565.595204167897;11587.188896777228;11655;11830;12088.62056384909;3812.4471951566866;3923.2153569286256;3933.0953880607335;3981.8009099545197;4108.548059713429;121251.3937430316;123875;123994.38002810019;125254.12118818225;125526;11306.434678266218;11575.652730418102;11677.474513646906;11757.706057348634;11797.587084452003;23248.186313478946;23632.881835590713;23667;23684.407889802893;23687.7631223689;7792.532448053135;8190.754277371689;8334.49993000422;8465;8482.872756908651;4400.559944005574;4577.382053422812;4587.174308624413;4688.367070445446;4719.5044520325555;3626.3472574936236;3675.4303083022173;3734.2158146788934;3735.626437356297;3738.4018557030745;624.5565648389694;631.1763149090481;632.2855173653742;639.3766078073934;648.6043513456788;713.9857202855914;722.7795522365728;759.4456047085548;764.8087978005499;790.8220650353625;10156.97874526739;10490.30900487167;10542.947285263524;10813.783724325627;10969.122470202365;620.9192804935329;661.7319985405918;721.5923003503004;731.9377852882458;735.8528294341153;4370.890727731832;5008.1486147355035;5140.074786538385;5173.663711858792;5193.506616871391;75146.62426687941;88038.67941980876;102724.48637756763;104090.47954760178;108331;73836;75060;78912.60543697244;81600;83631.7455238172;63810.68094659497;68190;70427;71393;72253.63873180706;10677.305975111592;11065.948734870175;11381.829272560753;11431.142664300045;11437.142214334124;48588.51411485981;48983;48997.755011226145;49814.50185498098;50402;61734;61855.38144618676;63587.364126358145;64190;64316.03525947021;12712.382106512447;13040.087193896336;13156.079074465079;13273.66815829612;13439.629881508534;14933.775993359892;15186.620334491727;15205.588046128145;15291.311890964711;15373.615659608598;13976.860231397555;14129.434822606981;14501.927490362481;14508.637284067561;14520.709585808436;13632.795508067586;13634;14530.564083077525;14843.332050057557;14844.480443184437;13206.141600795918;13926.721465570834;14160.929195353958;14164.716705666035;14200.502982395567;9200.631974720936;9666.854997174907;10391;10445.477726113815;10610.416427096583;9850.950745246228;10136.493175341351;11035.117190624891;11325.377104259016;11330.263532870336 10:43:50 INFO - PROCESS | 1641 | __end_tp_report 10:43:50 INFO - PROCESS | 1641 | __start_cc_report 10:43:50 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1356 10:43:50 INFO - PROCESS | 1641 | __end_cc_report 10:43:50 INFO - PROCESS | 1641 | __startTimestamp1492796630945__endTimestamp 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | ------- Summary: start ------- 10:43:50 INFO - PROCESS | 1641 | Number of tests: 6 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:6087.84 Median:6349.84 stddev:669.62 (10.5%) stddev-sans-first:641.80 10:43:50 INFO - PROCESS | 1641 | Values: 3566.5 3571.8 3603.1 3606.4 3648.3 6206.0 6219.3 6241.3 6245.6 6303.7 6208.5 6240.6 6266.6 6267.8 6275.7 5569.2 5592.0 5607.6 5640.9 5707.3 5469.3 5480.8 5512.2 5566.7 5716.3 5571.2 5580.0 5592.3 5592.3 5609.4 5608.0 5651.7 5654.1 5654.5 5659.2 5412.4 5466.8 5583.8 5589.6 5657.8 6102.2 6108.2 6121.1 6124.1 6129.1 6355.7 6405.2 6439.9 6505.1 6509.5 4750.7 6615.6 6618.8 6634.7 6636.1 6333.7 6340.7 6354.3 6356.1 6363.1 6391.8 6439.4 6689.9 6729.6 6808.4 5373.5 6442.0 6449.4 6460.0 6463.8 6538.1 6582.8 6601.9 6605.8 6607.6 6305.6 6349.8 6387.1 6484.7 6507.9 6401.6 6490.9 6510.8 6517.3 6523.7 5306.3 5333.0 5333.1 5343.7 5370.7 4609.4 4691.4 4739.1 4757.2 4769.5 6227.4 6323.4 6327.9 6355.7 6372.0 6535.0 6537.2 6539.6 6541.5 6551.8 6299.2 6332.7 6363.3 6368.2 6392.3 5631.1 5661.6 5719.7 5725.7 5732.4 6625.5 6677.5 6681.9 6698.8 6852.7 6549.7 6572.6 6579.9 6581.4 6588.6 6920.9 6943.6 6951.9 6960.9 6972.6 6311.9 6372.9 6466.7 6494.8 6499.0 5499.3 6450.7 6500.1 6564.7 6565.1 6412.4 6425.4 6426.2 6433.2 6444.1 5020.0 6391.3 6413.9 6414.4 6465.9 6184.8 6297.1 6346.6 6356.5 6367.6 5440.6 6369.0 6415.7 6416.3 6417.2 6291.5 6345.8 6346.2 6346.3 6346.6 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:55196.31 Median:191637.17 stddev:108940.43 (56.8%) stddev-sans-first:109169.30 10:43:50 INFO - PROCESS | 1641 | Values: 738.3 789.7 837.5 912.0 921.2 29435.9 39841.4 40352.6 43776.6 43990.8 42681.1 42773.8 42810.5 42826.0 42870.9 7883.6 8030.5 9529.0 9693.0 9697.4 7984.4 8061.0 8062.9 11582.4 11732.6 11703.5 11754.4 11793.3 11813.2 11862.6 11762.4 11762.9 11772.5 11785.7 11806.9 11468.9 11509.4 11514.3 11524.6 11556.5 38741.0 39004.8 39037.8 39089.4 39092.8 4005.9 4046.4 4074.3 4095.2 4112.6 23475.2 27492.2 30341.4 30669.4 30748.0 3167.1 3226.6 3288.9 3422.2 3424.0 348473.3 348781.0 348950.0 349289.0 349303.0 52912.7 53232.7 53412.0 53421.5 53651.5 55282.2 55336.2 55358.7 55422.0 55527.0 14304.4 14684.3 14688.2 14692.8 14777.8 12585.0 12587.7 12589.9 12593.0 12603.2 9449.8 9618.4 9733.6 11778.6 12173.9 4785.7 5455.5 5472.3 5480.9 5495.0 1151.1 1171.1 1183.5 1197.6 1204.3 27240.5 27497.9 27783.6 27794.7 27950.0 1274.5 1281.5 1282.2 1321.2 1323.1 12897.0 13971.4 14037.4 14251.7 14348.5 466096.0 466365.0 466593.0 467197.0 474733.0 42045.8 46886.5 51119.0 57230.0 61489.7 1310.2 1477.1 1506.6 1521.5 1521.7 22845.8 24875.0 29448.0 31074.1 31431.5 46958.8 47107.5 47194.3 47227.6 47245.0 406016.0 407018.0 408543.0 409064.9 409230.0 34801.1 35287.1 35332.9 35432.6 35587.6 40544.6 44837.8 44958.0 46372.0 46515.1 26513.6 28034.7 28490.0 28905.0 29019.6 27606.6 27612.2 28567.9 28850.3 29020.7 36632.6 37222.6 37304.0 37316.0 37465.8 26944.0 27784.6 27989.9 28149.6 28251.3 23423.8 24821.9 25022.6 25109.5 25409.6 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:44097.84 Median:23655.91 stddev:132680.47 (560.9%) stddev-sans-first:133012.16 10:43:50 INFO - PROCESS | 1641 | Values: 428.6 433.6 438.3 438.7 449.2 20922.7 21452.7 22888.7 22916.5 23028.0 23160.3 23423.3 24140.6 24313.4 24586.4 6972.1 7027.7 7076.9 7143.5 7153.7 6843.0 7124.2 7149.7 7156.7 7157.8 6812.9 7184.3 7190.1 7197.8 7202.7 6773.1 7029.3 7087.5 7110.2 7152.0 6923.7 6955.0 6977.2 6977.8 6982.9 26406.0 28054.2 28203.6 28538.4 30272.8 2962.7 3031.8 3048.5 3202.3 3233.9 16034.8 16677.0 16708.8 17182.8 17431.1 2027.4 2101.9 2135.6 2175.4 2274.5 91953.5 103286.0 110061.6 151372.2 166036.3 18986.7 19967.4 20073.8 20139.3 20158.9 30581.9 30613.2 30642.4 30729.8 30798.4 10269.8 10393.8 10560.3 10569.3 10729.7 8735.1 8759.3 8779.5 8912.0 8919.2 7904.8 9306.3 9418.3 9497.2 9521.9 3217.8 3310.9 3899.9 3906.4 3923.3 786.6 793.1 797.8 810.9 922.8 21819.0 22398.3 22628.8 23888.5 24907.8 1082.7 1086.4 1096.7 1108.2 1128.4 11769.4 11842.3 11947.6 12011.7 12059.7 772417.0 801967.0 802402.0 806492.0 820378.9 154262.0 155109.0 156389.2 156596.2 158022.5 1268.9 1289.1 1322.3 1323.5 1323.7 16217.4 19640.0 20322.0 20409.6 20410.2 62341.4 63852.0 63923.7 64801.0 65994.7 88133.0 88476.0 88677.6 90381.5 90605.5 11179.3 11603.4 11703.2 11775.5 11911.2 11246.6 13137.3 13199.3 13385.3 13578.4 10298.3 10870.7 11501.6 11550.7 11863.7 8718.0 9702.8 10056.5 10186.6 10227.2 11642.3 11714.4 11735.1 11764.0 12013.3 11479.3 11644.1 11693.2 11806.9 11913.3 9747.5 11125.3 11523.7 11664.7 11790.1 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:6758.79 Median:2453.29 stddev:4239.84 (172.8%) stddev-sans-first:4232.76 10:43:50 INFO - PROCESS | 1641 | Values: 1421.0 1578.1 1613.7 1634.2 1637.8 10877.1 11539.0 11553.0 11554.7 11626.6 11331.0 11413.5 11729.2 11937.9 11947.9 2452.4 2490.7 2498.1 2501.2 2506.0 2407.2 2417.4 2460.9 2472.8 2474.3 2419.1 2432.6 2439.0 2454.2 2457.3 2371.1 2413.3 2429.2 2431.8 2439.8 2426.2 2443.8 2452.4 2457.6 2460.5 11359.3 11583.4 11592.6 11614.8 11623.0 5774.2 5974.2 5983.7 5985.4 5993.9 3127.2 3457.9 3582.5 3582.8 3620.8 1131.3 1132.2 1147.3 1232.0 1285.2 13923.0 14196.6 14539.3 15558.0 15784.2 4595.3 4707.0 4714.0 4732.2 4735.9 10319.9 10530.9 11882.3 11903.4 11905.3 4981.4 5033.9 5055.7 5067.8 5680.7 5192.4 5286.0 5330.6 5345.2 5368.7 3891.9 3898.2 3923.7 3974.6 4021.1 1012.3 1021.7 1025.8 1028.0 1029.3 963.2 973.7 1009.8 1018.6 1026.2 5389.8 6575.2 6640.3 6653.7 6771.7 965.3 1019.9 1025.9 1069.2 1079.9 4080.4 4177.5 4244.9 4246.3 4343.8 13377.6 13921.4 13947.6 13959.4 13965.7 13530.7 13652.9 13839.9 13998.6 14023.4 10326.0 10389.9 10394.4 10413.7 10455.4 6440.4 6558.4 6693.7 6725.1 6757.8 12112.8 12296.3 12360.6 12419.0 12454.2 11140.9 11648.7 12470.4 12561.6 13112.9 8506.7 8654.0 8777.0 8789.5 8790.3 10539.7 10608.4 10625.3 10716.9 10788.6 8437.0 8443.2 8499.6 8500.9 8536.2 8341.2 8370.2 8549.5 8561.2 8580.7 7811.0 8022.7 8202.4 8329.7 8348.5 4982.8 5835.5 5896.8 6027.2 6049.6 5086.9 6060.4 6104.1 6196.0 6203.5 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4578.01 Median:4949.62 stddev:1293.26 (26.1%) stddev-sans-first:1258.20 10:43:50 INFO - PROCESS | 1641 | Values: 394.9 395.8 399.1 400.5 401.6 4557.3 5220.7 5324.3 5372.0 5386.2 4668.2 4874.9 5045.0 5167.3 5250.3 3670.8 3707.4 4021.7 4135.3 4185.8 3726.9 4197.2 4202.3 4227.8 4249.4 3909.9 4158.8 4186.3 4197.9 4211.0 3357.3 3469.0 4119.8 4121.9 4148.7 3651.9 3672.2 3673.6 3689.3 3708.5 4597.3 4619.6 4681.0 4744.6 4858.3 4081.9 4547.5 4739.0 4832.7 4909.5 5178.6 5568.9 5583.6 5587.4 5594.0 3511.3 4012.0 4073.6 4090.2 4112.3 5607.4 5704.1 5777.5 5851.9 5889.9 3500.0 3725.9 3968.5 4120.1 4162.3 4241.5 4302.5 4303.9 4308.7 4309.3 3918.2 4501.2 4595.2 4788.3 4894.0 4743.3 5023.2 5626.6 5653.6 5670.0 1696.5 1715.0 1721.8 1740.3 1743.5 1240.0 1281.7 1315.2 1358.0 1382.0 4568.9 4697.1 5040.4 5256.6 5309.5 5081.7 5186.0 5256.4 5722.7 5726.5 4328.5 4748.5 4811.5 4926.8 5153.0 2591.9 2613.6 2980.0 2996.7 2997.5 5135.2 5533.2 5540.5 5931.6 6082.9 5041.0 5144.3 5306.6 5760.3 5994.2 4997.6 5920.9 5938.7 6116.8 6126.3 4938.8 4944.4 5029.8 5089.9 5112.5 4541.5 5658.6 5744.5 5759.3 5802.0 5289.3 6082.0 6108.4 6130.9 6137.3 4470.3 4915.7 4954.9 4955.0 4963.5 4988.8 5130.4 5627.7 5816.6 5822.5 5000.0 5610.0 5633.9 5654.7 5725.6 5342.0 5491.5 5598.6 5649.8 5727.3 5171.7 5373.3 5434.2 5479.1 5605.0 4938.9 5124.6 5133.8 5152.9 5644.6 5124.7 5485.7 5505.8 5544.5 5548.7 10:43:50 INFO - PROCESS | 1641 | 10:43:50 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20545.30 Median:16470.59 stddev:29154.46 (177.0%) stddev-sans-first:29198.41 10:43:50 INFO - PROCESS | 1641 | Values: 763.4 785.7 801.4 871.3 885.0 16074.2 17657.4 17657.7 17705.5 17737.4 16058.0 16182.9 16183.6 16234.4 16298.8 1000.6 1017.3 1029.9 1051.7 1053.9 1030.5 1034.3 1035.3 1036.6 1037.2 1079.3 1079.3 1082.0 1083.1 1086.6 1079.1 1080.9 1082.0 1083.2 1083.5 806.0 807.5 808.4 809.3 813.3 16642.4 17277.4 17463.7 17573.7 17882.3 14619.3 14842.5 14930.9 15013.0 15095.9 11565.6 11587.2 11655.0 11830.0 12088.6 3812.4 3923.2 3933.1 3981.8 4108.5 121251.4 123875.0 123994.4 125254.1 125526.0 11306.4 11575.7 11677.5 11757.7 11797.6 23248.2 23632.9 23667.0 23684.4 23687.8 7792.5 8190.8 8334.5 8465.0 8482.9 4400.6 4577.4 4587.2 4688.4 4719.5 3626.3 3675.4 3734.2 3735.6 3738.4 624.6 631.2 632.3 639.4 648.6 714.0 722.8 759.4 764.8 790.8 10157.0 10490.3 10542.9 10813.8 10969.1 620.9 661.7 721.6 731.9 735.9 4370.9 5008.1 5140.1 5173.7 5193.5 75146.6 88038.7 102724.5 104090.5 108331.0 73836.0 75060.0 78912.6 81600.0 83631.7 63810.7 68190.0 70427.0 71393.0 72253.6 10677.3 11065.9 11381.8 11431.1 11437.1 48588.5 48983.0 48997.8 49814.5 50402.0 61734.0 61855.4 63587.4 64190.0 64316.0 12712.4 13040.1 13156.1 13273.7 13439.6 14933.8 15186.6 15205.6 15291.3 15373.6 13976.9 14129.4 14501.9 14508.6 14520.7 13632.8 13634.0 14530.6 14843.3 14844.5 13206.1 13926.7 14160.9 14164.7 14200.5 9200.6 9666.9 10391.0 10445.5 10610.4 9851.0 10136.5 11035.1 11325.4 11330.3 10:43:50 INFO - PROCESS | 1641 | -------- Summary: end -------- 10:43:50 INFO - PROCESS | 1641 | 10:43:51 INFO - TEST-INFO | 1641: exit 0 10:43:51 INFO - TEST-OK | dromaeo_css | took 1118463ms 10:43:51 INFO - TEST-START | kraken 10:43:51 INFO - operating with platform_type : mac_ 10:43:51 INFO - Initialising browser for kraken test... 10:43:51 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpbwxeo0/profile http://localhost:49249/getInfo.html) 10:43:53 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:43:53 INFO - PROCESS | 1651 | colorDepth:24 10:43:53 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 10:43:53 INFO - PROCESS | 1651 | __metrics 10:43:53 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" 10:43:53 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] 10:43:54 INFO - TEST-INFO | 1651: exit 0 10:43:54 INFO - Browser initialized. 10:43:54 INFO - Running cycle 1/1 for kraken test... 10:43:54 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpbwxeo0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:44:06 INFO - PROCESS | 1653 | RSS: Main: 165593088 10:44:06 INFO - PROCESS | 1653 | 10:44:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:44:10 INFO - PROCESS | 1653 | RSS: Main: 216010752 10:44:10 INFO - PROCESS | 1653 | 10:44:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:44:13 INFO - PROCESS | 1653 | RSS: Main: 231235584 10:44:13 INFO - PROCESS | 1653 | 10:44:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:44:17 INFO - PROCESS | 1653 | RSS: Main: 327532544 10:44:17 INFO - PROCESS | 1653 | 10:44:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:44:20 INFO - PROCESS | 1653 | RSS: Main: 230244352 10:44:20 INFO - PROCESS | 1653 | 10:44:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:44:22 INFO - PROCESS | 1653 | RSS: Main: 232128512 10:44:22 INFO - PROCESS | 1653 | 10:44:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:44:26 INFO - PROCESS | 1653 | RSS: Main: 272388096 10:44:26 INFO - PROCESS | 1653 | 10:44:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:44:29 INFO - PROCESS | 1653 | RSS: Main: 271958016 10:44:29 INFO - PROCESS | 1653 | 10:44:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:44:33 INFO - PROCESS | 1653 | RSS: Main: 270848000 10:44:33 INFO - PROCESS | 1653 | 10:44:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:44:35 INFO - PROCESS | 1653 | RSS: Main: 247599104 10:44:35 INFO - PROCESS | 1653 | 10:44:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:44:37 INFO - PROCESS | 1653 | RSS: Main: 251359232 10:44:37 INFO - PROCESS | 1653 | 10:44:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:44:40 INFO - PROCESS | 1653 | RSS: Main: 255086592 10:44:40 INFO - PROCESS | 1653 | 10:44:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:44:44 INFO - PROCESS | 1653 | RSS: Main: 272932864 10:44:44 INFO - PROCESS | 1653 | 10:44:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:44:47 INFO - PROCESS | 1653 | RSS: Main: 266563584 10:44:47 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:44:49 INFO - PROCESS | 1653 | RSS: Main: 311123968 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | __start_tp_report 10:44:49 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 10:44:49 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 10:44:49 INFO - PROCESS | 1653 | |i|pagename|runs| 10:44:49 INFO - PROCESS | 1653 | |0;ai-astar;105;116;114;130;168;170;115;113;116;116 10:44:49 INFO - PROCESS | 1653 | |1;audio-beat-detection;143;106;110;143;111;110;112;131;157;137 10:44:49 INFO - PROCESS | 1653 | |2;audio-dft;186;184;182;182;182;183;184;184;183;186 10:44:49 INFO - PROCESS | 1653 | |3;audio-fft;78;60;61;91;60;58;58;59;75;58 10:44:49 INFO - PROCESS | 1653 | |4;audio-oscillator;78;70;85;68;71;68;82;68;68;82 10:44:49 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;87;87;87;88;88;87;84;88;86 10:44:49 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;93;93;94;94;93;91;117;106;88 10:44:49 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;83;93;84;83;83;83;86;86;84 10:44:49 INFO - PROCESS | 1653 | |8;json-parse-financial;63;59;60;60;61;63;63;63;62;63 10:44:49 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;55;61;57;64;59;59;58;59;58;59 10:44:49 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;81;84;87;80;80;83;82;80;77;81 10:44:49 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;132;133;144;134;131;134;156;140;192;162 10:44:49 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;162;151;208;213;203;162;161;162;162;164 10:44:49 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;63;64;65;63;65;76;75;79;76;62 10:44:49 INFO - PROCESS | 1653 | __end_tp_report 10:44:49 INFO - PROCESS | 1653 | __start_cc_report 10:44:49 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2102 10:44:49 INFO - PROCESS | 1653 | __end_cc_report 10:44:49 INFO - PROCESS | 1653 | __startTimestamp1492796689719__endTimestamp 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | ------- Summary: start ------- 10:44:49 INFO - PROCESS | 1653 | Number of tests: 14 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:126.30 Median:116.00 stddev:23.31 (20.1%) stddev-sans-first:23.41 10:44:49 INFO - PROCESS | 1653 | Values: 105.0 116.0 114.0 130.0 168.0 170.0 115.0 113.0 116.0 116.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:134.00 stddev:18.31 (13.7%) stddev-sans-first:18.36 10:44:49 INFO - PROCESS | 1653 | Values: 143.0 106.0 110.0 143.0 111.0 110.0 112.0 131.0 157.0 137.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.51 (0.8%) stddev-sans-first:1.32 10:44:49 INFO - PROCESS | 1653 | Values: 186.0 184.0 182.0 182.0 182.0 183.0 184.0 184.0 183.0 186.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.49 (19.0%) stddev-sans-first:11.30 10:44:49 INFO - PROCESS | 1653 | Values: 78.0 60.0 61.0 91.0 60.0 58.0 58.0 59.0 75.0 58.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:74.00 Median:74.50 stddev:6.94 (9.3%) stddev-sans-first:7.21 10:44:49 INFO - PROCESS | 1653 | Values: 78.0 70.0 85.0 68.0 71.0 68.0 82.0 68.0 68.0 82.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.50 stddev:1.25 (1.4%) stddev-sans-first:1.27 10:44:49 INFO - PROCESS | 1653 | Values: 88.0 87.0 87.0 87.0 88.0 88.0 87.0 84.0 88.0 86.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:93.00 stddev:8.62 (9.3%) stddev-sans-first:9.10 10:44:49 INFO - PROCESS | 1653 | Values: 94.0 93.0 93.0 94.0 94.0 93.0 91.0 117.0 106.0 88.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:3.07 (3.6%) stddev-sans-first:3.24 10:44:49 INFO - PROCESS | 1653 | Values: 86.0 83.0 93.0 84.0 83.0 83.0 83.0 86.0 86.0 84.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:63.00 stddev:1.57 (2.5%) stddev-sans-first:1.59 10:44:49 INFO - PROCESS | 1653 | Values: 63.0 59.0 60.0 60.0 61.0 63.0 63.0 63.0 62.0 63.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:2.38 (4.0%) stddev-sans-first:2.06 10:44:49 INFO - PROCESS | 1653 | Values: 55.0 61.0 57.0 64.0 59.0 59.0 58.0 59.0 58.0 59.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.50 stddev:2.72 (3.3%) stddev-sans-first:2.88 10:44:49 INFO - PROCESS | 1653 | Values: 81.0 84.0 87.0 80.0 80.0 83.0 82.0 80.0 77.0 81.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:142.00 stddev:19.41 (13.7%) stddev-sans-first:19.93 10:44:49 INFO - PROCESS | 1653 | Values: 132.0 133.0 144.0 134.0 131.0 134.0 156.0 140.0 192.0 162.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:163.00 stddev:23.30 (14.3%) stddev-sans-first:24.25 10:44:49 INFO - PROCESS | 1653 | Values: 162.0 151.0 208.0 213.0 203.0 162.0 161.0 162.0 162.0 164.0 10:44:49 INFO - PROCESS | 1653 | 10:44:49 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:70.00 stddev:6.76 (9.7%) stddev-sans-first:6.84 10:44:49 INFO - PROCESS | 1653 | Values: 63.0 64.0 65.0 63.0 65.0 76.0 75.0 79.0 76.0 62.0 10:44:49 INFO - PROCESS | 1653 | -------- Summary: end -------- 10:44:49 INFO - PROCESS | 1653 | 10:44:50 INFO - TEST-INFO | 1653: exit 0 10:44:50 INFO - TEST-OK | kraken | took 58967ms 10:44:50 INFO - SUITE-END | took 1177s 10:44:50 INFO - Completed test suite (00:19:37) 10:44:50 INFO - javascript benchmark 10:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7853.9115948185845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3566.5185199998, 3571.785692858429, 3603.0812142903555, 3606.350856845767, 3648.343298206322, 6206.038064100072, 6219.253689557254, 6241.344658810827, 6245.56281060326, 6303.6532990685555, 6208.534359923013, 6240.563160578761, 6266.592671476351, 6267.811965641038, 6275.68621568922, 5569.164625306216, 5592.049351610226, 5607.607467477278, 5640.943590564083, 5707.258056452655, 5469.316335458067, 5480.7533660985355, 5512.228288039678, 5566.693831839248, 5716.3426205986425, 5571.247881535981, 5579.972100139494, 5592.3009623797025, 5592.328920529521, 5609.411011843738, 5607.990561698893, 5651.660900345972, 5654.067078931971, 5654.547636189095, 5659.151127330892, 5412.404635490093, 5466.753996070186, 5583.832485025456, 5589.608727389084, 5657.773689052433, 6102.176206212149, 6108.175396321484, 6121.081837724332, 6124.050772130327, 6129.111278864584, 6355.682215889234, 6405.167328247345, 6439.903401448982, 6505.121808555879, 6509.544331896769, 4750.691205071694, 6615.569987950816, 6618.834529136762, 6634.734610615569, 6636.137302150738, 6333.651649159295, 6340.651264180468, 6354.332795056545, 6356.14192084072, 6363.140975968277, 6391.840203994844, 6439.388258115471, 6689.866202675919, 6729.596224226562, 6808.4212841908, 5373.462653734673, 6441.967790161113, 6449.3873082057125, 6460.0, 6463.838404039842, 6538.117354157223, 6582.80251592453, 6601.933980660228, 6605.768798092044, 6607.570507917067, 6305.621662700161, 6349.841253968595, 6387.073874288295, 6484.740610375627, 6507.934920650733, 6401.615903045739, 6490.902636460457, 6510.837229069217, 6517.348265173445, 6523.6738163092605, 5306.257124002643, 5332.9733351333, 5333.066713325153, 5343.65266257692, 5370.677759334452, 4609.423822022247, 4691.437027556715, 4739.075880203327, 4757.238841785298, 4769.499202583679, 6227.408396202444, 6323.399277068671, 6327.905081423783, 6355.650439225795, 6372.044193371032, 6535.0, 6537.1501704778075, 6539.607623542507, 6541.5093867960095, 6551.80344589663, 6299.1811064562235, 6332.651704156224, 6363.268224154189, 6368.172137622172, 6392.26488953767, 5631.1271752878365, 5661.575381846295, 5719.742611582489, 5725.656460612377, 5732.369439361667, 6625.469962403093, 6677.499187560855, 6681.899771503528, 6698.7990360288295, 6852.691628876612, 6549.7380104795275, 6572.605643661395, 6579.934200658124, 6581.407673309425, 6588.637624930675, 6920.9307906920285, 6943.583384996917, 6951.895721564079, 6960.895586566105, 6972.616506092214, 6311.936880631135, 6372.904406433814, 6466.708998095191, 6494.805155845333, 6499.0, 5499.285092937893, 6450.709718062604, 6500.057491663777, 6564.737410503526, 6565.113709649328, 6412.39082287182, 6425.389587989133, 6426.228852537725, 6433.228012638326, 6444.097826304415, 5019.974900125622, 6391.32891046452, 6413.935860641521, 6414.390632889868, 6465.935340646533, 6184.845378865564, 6297.118403423616, 6346.555741098264, 6356.459700925473, 6367.649779261999, 5440.591955603425, 6368.968155159195, 6415.71129299192, 6416.32628573993, 6417.197850268716, 6291.496680265476, 6345.841353966188, 6346.174997250512, 6346.333634968447, 6346.555741098079], "value": 6048.142497738067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.3133685672326, 789.7078081109987, 837.5267973594916, 911.977200569986, 921.2123634292675, 29435.852820735894, 39841.4023789643, 40352.59647403525, 43776.56223437765, 43990.780046099724, 42681.14637707252, 42773.786131069304, 42810.50163244287, 42826.0, 42870.92822679435, 7883.566403847786, 8030.5181689098845, 9529.0, 9692.95153524235, 9697.3696709714, 7984.441089123764, 8061.0326760788785, 8062.879056814123, 11582.362970036645, 11732.648020559354, 11703.53185872564, 11754.353510556915, 11793.292402455838, 11813.232139910879, 11862.644120676394, 11762.353070581115, 11762.882371176263, 11772.470238839272, 11785.705357366134, 11806.937375636147, 11468.942655286754, 11509.424528773528, 11514.251573647769, 11524.596639117675, 11556.53773849045, 38741.0, 39004.82985510439, 39037.82886513409, 39089.41365879486, 39092.804535977135, 4005.859794907193, 4046.3728122141115, 4074.327735923569, 4095.201435720036, 4112.629863312286, 23475.17836875718, 27492.17523474279, 30341.393172136653, 30669.38661226763, 30748.0, 3167.129039514129, 3226.6289376721743, 3288.917777055569, 3422.178677117499, 3423.96576034239, 348473.2576337102, 348781.0, 348950.0, 349289.0, 349303.0, 52912.735436322575, 53232.73383633057, 53412.0, 53421.46578534243, 53651.46348536543, 55282.17076743852, 55336.16995745067, 55358.723206384515, 55422.0, 55527.0, 14304.356303966346, 14684.339204735812, 14688.19214943167, 14692.779608305671, 14777.778333325008, 12585.0, 12587.748245035047, 12589.93705031469, 12592.99256059513, 12603.243805371707, 9449.76375590602, 9618.422894626345, 9733.561989710339, 11778.5877494289, 12173.878261217274, 4785.688930219525, 5455.509004189642, 5472.315960504937, 5480.890382192334, 5494.972525137348, 1151.113642495274, 1171.1158075652997, 1183.526589364261, 1197.5628895453096, 1204.3436327201696, 27240.45519089607, 27497.900083996417, 27783.58324625132, 27794.722052779616, 27950.0, 1274.5347947999098, 1281.51943021367, 1282.2370689439767, 1321.2402868350737, 1323.1002918015843, 12897.032722545846, 13971.371288291848, 14037.438502459787, 14251.714965700628, 14348.49780257686, 466096.0, 466365.0, 466593.0, 467197.0, 474733.0, 42045.78977105095, 46886.5311346889, 51119.0, 57230.0, 61489.69255153785, 1310.2007775257086, 1477.106350657858, 1506.6231751461908, 1521.4522771802365, 1521.7260893039359, 22845.77154228503, 24875.0, 29448.0, 31074.115735533058, 31431.528527071656, 46958.76520617375, 47107.52892471168, 47194.29208561806, 47227.58317250488, 47245.0, 406016.0, 407018.0, 408543.0, 409064.9093509146, 409230.0, 34801.08594027353, 35287.11782205466, 35332.940011799685, 35432.64567354293, 35587.644123558435, 40544.594554054085, 44837.77581112074, 44958.0, 46372.0, 46515.069698606516, 26513.60229596596, 28034.71965280321, 28490.002849900153, 28905.0, 29019.564706528996, 27606.5859012119, 27612.171634850987, 28567.857160714062, 28850.27874303159, 29020.709792901802, 36632.633673662924, 37222.62777372191, 37304.0, 37316.0, 37465.81267093647, 26944.0, 27784.583231251952, 27989.86005070043, 28149.577756333263, 28251.2937176564, 23423.76576234216, 24821.87589062043, 25022.62466063047, 25109.497810043333, 25409.61885571681], "value": 19018.622687020757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.63351834181793, 433.6054190686474, 438.2965340628292, 438.7104511022725, 449.21611787430936, 20922.6861597076, 21452.678209826845, 22888.65667014994, 22916.541669166607, 23028.0, 23160.30519084426, 23423.297301080995, 24140.637890431615, 24313.392165195877, 24586.385340366498, 6972.093627828388, 7027.664743698707, 7076.85846283074, 7143.499955003152, 7153.713851445936, 6842.965785171067, 7124.180719217278, 7149.678264478111, 7156.749513767019, 7157.785266441989, 6812.931870681279, 7184.317489838483, 7190.101237345332, 7197.784066478014, 7202.711891524333, 6773.119494465713, 7029.332213439715, 7087.539309944863, 7110.217876033632, 7152.0, 6923.723051077951, 6955.0, 6977.232504424509, 6977.825554361131, 6982.895256571155, 26406.0, 28054.158375248775, 28203.57694634582, 28538.429231415255, 30272.84863575668, 2962.674105848355, 3031.8332491712945, 3048.4512787698204, 3202.327511222646, 3233.8868139615, 16034.75947860783, 16676.999380037236, 16708.83291167085, 17182.828171718247, 17431.128443577898, 2027.432318950696, 2101.8843963582, 2135.6049130910833, 2175.380016695234, 2274.465500607356, 91953.54023229908, 103286.0, 110061.62188809465, 151372.2431387847, 166036.33963660328, 18986.71519927202, 19967.400977970683, 20073.799262007484, 20139.295124670858, 20158.89920550388, 30581.929632462758, 30613.234669133006, 30642.387152257277, 30729.846350768552, 30798.384032319227, 10269.845952310721, 10393.792124157626, 10560.313579617301, 10569.312994655324, 10729.731756705989, 8735.126487351214, 8759.34304927133, 8779.517126558101, 8911.955440222757, 8919.241864441465, 7904.762857114296, 9306.302027347976, 9418.29362797793, 9497.192738617157, 9521.857172142423, 3217.7747557671205, 3310.8841190558214, 3899.941500877489, 3906.3554513504955, 3923.313420151462, 786.6420778545748, 793.1216352038537, 797.8125140591957, 810.8621534339177, 922.7785331520387, 21819.0, 22398.328050158194, 22628.773712262995, 23888.52222955531, 24907.750922490904, 1082.7401423658423, 1086.3916206924148, 1096.660035389032, 1108.1854836695022, 1128.418864284894, 11769.352685602204, 11842.348670823016, 11947.581834635746, 12011.699707507381, 12059.698507537207, 772417.0, 801967.0, 802402.0, 806492.0, 820378.8981055176, 154262.0, 155109.0, 156389.218053909, 156596.21701891645, 158022.469213577, 1268.8921441677376, 1289.1233960906673, 1322.2925734731873, 1323.4970711129708, 1323.6558494791232, 16217.432389866299, 19640.0, 20322.0, 20409.591808164052, 20410.18359265613, 62341.37658623537, 63852.0, 63923.68038159779, 64801.0, 65994.67002664956, 88133.0, 88476.0, 88677.55661221653, 90381.54809226174, 90605.54697226471, 11179.329240245612, 11603.36181510025, 11703.180777345504, 11775.52897884075, 11911.225770324902, 11246.606368777053, 13137.277449740355, 13199.34003299812, 13385.263810490516, 13578.38897249646, 10298.279120461495, 10870.728231794268, 11501.597444089417, 11550.711232219262, 11863.703407414538, 8717.956410217908, 9702.805943881223, 10056.533163468417, 10186.643467478603, 10227.181825453798, 11642.301461912313, 11714.355710435668, 11735.061195104541, 11764.0, 12013.279203247834, 11479.25384849982, 11644.126690498077, 11693.239939403911, 11806.940965295118, 11913.344766037952, 9747.463889486145, 11125.332480051224, 11523.711907202387, 11664.708382290512, 11790.115741319263], "value": 11764.5055956615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.992895035525, 1578.0689393257976, 1613.7418013117904, 1634.1665750467262, 1637.8444047815453, 10877.129829613632, 11538.961493465597, 11553.017993470565, 11554.65336039919, 11626.593069242579, 11330.98021178096, 11413.486393112309, 11729.240613907918, 11937.880621193786, 11947.940260298708, 2452.386903274186, 2490.7260201377835, 2498.0757119865675, 2501.2371226775826, 2506.0226511660376, 2407.229686500312, 2417.3714834143075, 2460.938476538083, 2472.777450029497, 2474.3195621204222, 2419.080749315258, 2432.6351047342864, 2439.0, 2454.202384225125, 2457.3242358351417, 2371.0515793682493, 2413.3001429585397, 2429.2105065853666, 2431.756824317563, 2439.780419762221, 2426.2478631624253, 2443.8289319747623, 2452.3746444656676, 2457.6313552967017, 2460.5447992121517, 11359.261647992855, 11583.420828958519, 11592.594259200887, 11614.76770464586, 11623.0, 5774.249347584787, 5974.22335096439, 5983.700814959235, 5985.40145985398, 5993.910091348634, 3127.218195451137, 3457.861685532576, 3582.5163602913794, 3582.802945837978, 3620.818959052037, 1131.349474052415, 1132.179170101678, 1147.2657499200434, 1231.975360492785, 1285.1710646632869, 13923.0, 14196.645083872985, 14539.3457294422, 15558.0, 15784.210789460596, 4595.310703394518, 4706.95293047072, 4714.033623107255, 4732.171869922819, 4735.857924262277, 10319.94840025795, 10530.894691052992, 11882.28706277626, 11903.404829758478, 11905.345206013752, 4981.352424184905, 5033.924491132562, 5055.6713813602, 5067.847964561069, 5680.68756218412, 5192.3769147702515, 5286.048511268009, 5330.626856120112, 5345.224942383333, 5368.651037682538, 3891.9416208756893, 3898.200868821885, 3923.7449565778134, 3974.6025397460603, 4021.1354558770004, 1012.2863381316301, 1021.7190272674925, 1025.779457416659, 1027.992567284066, 1029.2692188546066, 963.1524258652481, 973.73709098543, 1009.8131845608586, 1018.6383833738915, 1026.153423425662, 5389.757460914268, 6575.243846957565, 6640.269570347258, 6653.700583473756, 6771.661416929134, 965.280865755017, 1019.8827134879584, 1025.8922813104666, 1069.1820757120809, 1079.9298045627008, 4080.4287399764057, 4177.519585247735, 4244.893877653021, 4246.320588705854, 4343.847965321199, 13377.598672039854, 13921.373538190806, 13947.58157255284, 13959.371828267753, 13965.650858728613, 13530.729385412236, 13652.880169936274, 13839.861601384058, 13998.580042598738, 14023.368948397347, 10326.0, 10389.94805025985, 10394.376337419779, 10413.739656508647, 10455.424951627581, 6440.355964403522, 6558.442532384801, 6693.665316734241, 6725.125733654593, 6757.797266082025, 12112.84927931845, 12296.323702196465, 12360.567380141652, 12419.0, 12454.190477618926, 11140.888591113986, 11648.650540483799, 12470.438830252479, 12561.623151305475, 13112.934435327763, 8506.659733610833, 8654.0, 8777.0, 8789.516576588348, 8790.340724445565, 10539.736506587396, 10608.416537090225, 10625.25623206399, 10716.946415267874, 10788.568457261936, 8436.957815210884, 8443.197896199852, 8499.617517211864, 8500.91499085026, 8536.231739143506, 8341.165883411853, 8370.246677799027, 8549.529775862138, 8561.1866872647, 8580.742577722678, 7810.984572005603, 8022.679092836222, 8202.425830191829, 8329.708460203863, 8348.540830254395, 4982.7508624569355, 5835.4748072673665, 5896.7936122235515, 6027.156198132177, 6049.576529642883, 5086.898262034812, 6060.424259695322, 6104.053871649901, 6195.969020155051, 6203.534734894811], "value": 5164.416726749015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9052227465408, 395.79814294709706, 399.056232011293, 400.5472824254923, 401.63049994005513, 4557.270836666125, 5220.68675879447, 5324.334458192726, 5372.0, 5386.245925570418, 4668.18306796311, 4874.8537543873745, 5045.016221836743, 5167.250748641454, 5250.327208784176, 3670.7981061041633, 3707.3697471429923, 4021.7385869918435, 4135.250058710953, 4185.769782661952, 3726.88819335419, 4197.16056788642, 4202.348635961431, 4227.837344730208, 4249.362595610668, 3909.863154789583, 4158.750474971512, 4186.299836605388, 4197.8530751423705, 4210.97894510527, 3357.2949680567112, 3468.959312206328, 4119.754733670157, 4121.91756164878, 4148.709590328663, 3651.8958884947583, 3672.155404257009, 3673.5591728992426, 3689.2990331836863, 3708.479523395395, 4597.310403439477, 4619.584237418615, 4680.970186558951, 4744.572988431023, 4858.344123543312, 4081.8979525511804, 4547.53863978109, 4738.976305118453, 4832.710037397732, 4909.459959404463, 5178.556260087038, 5568.9443105568835, 5583.637063590853, 5587.379659898625, 5594.042085270164, 3511.348931556684, 4011.97994010031, 4073.6130067643526, 4090.1819636072905, 4112.300908845504, 5607.448610882079, 5704.058830292996, 5777.537796976232, 5851.882962340729, 5889.882202355929, 3500.0, 3725.906852328659, 3968.543617483969, 4120.134771697917, 4162.313218319004, 4241.4698162729655, 4302.505211900609, 4303.870883873489, 4308.655307575386, 4309.332053531708, 3918.2359439908946, 4501.234790085693, 4595.2188128018315, 4788.281757736368, 4894.0, 4743.264793956942, 5023.196288593807, 5626.634268772516, 5653.614864358176, 5670.043834876961, 1696.4910526842145, 1715.0, 1721.8278172182681, 1740.26908698347, 1743.4943866278636, 1239.9938000310121, 1281.6731733407921, 1315.1977293850744, 1358.0444160408979, 1381.9723605528034, 4568.931466028012, 4697.107549565571, 5040.420351659606, 5256.579473642099, 5309.469202980053, 5081.720505372166, 5185.9740701297005, 5256.423073078061, 5722.685252311163, 5726.513246374105, 4328.458942632171, 4748.477667456577, 4811.518848115161, 4926.842192084857, 5153.0, 2591.9092831751177, 2613.6079588061943, 2980.0, 2996.6853480384248, 2997.5461900978007, 5135.177012160704, 5533.22534845122, 5540.473655002768, 5931.606072572942, 6082.939170608237, 5041.033996741274, 5144.321809905935, 5306.602004849652, 5760.308762948389, 5994.1608174855555, 4997.625178111656, 5920.911186332209, 5938.703064846827, 6116.785912493041, 6126.295476020226, 4938.839142948587, 4944.357233559758, 5029.798808047637, 5089.949100508948, 5112.488751125006, 4541.500434952087, 5658.585353661585, 5744.454276843693, 5759.337676167127, 5802.0, 5289.312389389354, 6082.0, 6108.419700128481, 6130.938690613215, 6137.294211165595, 4470.329450582439, 4915.729634870117, 4954.8761280968265, 4954.950450495449, 4963.478834722302, 4988.825391111293, 5130.384353877558, 5627.7467513961155, 5816.621919575214, 5822.4759771619065, 5000.0, 5610.0, 5633.943660563342, 5654.7455364509515, 5725.570582206435, 5341.985022845647, 5491.533219676372, 5598.608097433141, 5649.830505084854, 5727.341355744143, 5171.715555644325, 5373.2746079278795, 5434.212039254365, 5479.0959491683425, 5604.99110160175, 4938.876528086683, 5124.564412024871, 5133.820316289061, 5152.871178220575, 5644.6330988485615, 5124.692518448905, 5485.698286594116, 5505.807296744755, 5544.500994910478, 5548.667079975215], "value": 4222.16971552283, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.4159867701213, 785.6660919109377, 801.4229754576706, 871.2724874729602, 884.9823003539931, 16074.196290185488, 17657.381991630296, 17657.735133973, 17705.46883593491, 17737.37919172829, 16058.0, 16182.919085404586, 16183.595410114753, 16234.431794887181, 16298.755518667229, 1000.5791775678535, 1017.2574020964663, 1029.907308342249, 1051.6634676903393, 1053.8629978102836, 1030.469308306219, 1034.3380236648552, 1035.3425574760006, 1036.6164519127894, 1037.2169012395632, 1079.3254216114929, 1079.3362082319356, 1081.967540973772, 1083.0956151613373, 1086.6414083352515, 1079.0773888325448, 1080.864891888514, 1081.9729506762314, 1083.2363183955292, 1083.4961742789562, 806.0166596752011, 807.5195258821051, 808.3735105293445, 809.2676128104075, 813.3493205435627, 16642.417515386904, 17277.39529116475, 17463.738043929352, 17573.7363939541, 17882.28470861164, 14619.342129604192, 14842.480513181987, 14930.925345373204, 15013.0, 15095.943283970126, 11565.595204167897, 11587.188896777228, 11655.0, 11830.0, 12088.62056384909, 3812.4471951566866, 3923.2153569286256, 3933.0953880607335, 3981.8009099545197, 4108.548059713429, 121251.3937430316, 123875.0, 123994.38002810019, 125254.12118818225, 125526.0, 11306.434678266218, 11575.652730418102, 11677.474513646906, 11757.706057348634, 11797.587084452003, 23248.186313478946, 23632.881835590713, 23667.0, 23684.407889802893, 23687.7631223689, 7792.532448053135, 8190.754277371689, 8334.49993000422, 8465.0, 8482.872756908651, 4400.559944005574, 4577.382053422812, 4587.174308624413, 4688.367070445446, 4719.5044520325555, 3626.3472574936236, 3675.4303083022173, 3734.2158146788934, 3735.626437356297, 3738.4018557030745, 624.5565648389694, 631.1763149090481, 632.2855173653742, 639.3766078073934, 648.6043513456788, 713.9857202855914, 722.7795522365728, 759.4456047085548, 764.8087978005499, 790.8220650353625, 10156.97874526739, 10490.30900487167, 10542.947285263524, 10813.783724325627, 10969.122470202365, 620.9192804935329, 661.7319985405918, 721.5923003503004, 731.9377852882458, 735.8528294341153, 4370.890727731832, 5008.1486147355035, 5140.074786538385, 5173.663711858792, 5193.506616871391, 75146.62426687941, 88038.67941980876, 102724.48637756763, 104090.47954760178, 108331.0, 73836.0, 75060.0, 78912.60543697244, 81600.0, 83631.7455238172, 63810.68094659497, 68190.0, 70427.0, 71393.0, 72253.63873180706, 10677.305975111592, 11065.948734870175, 11381.829272560753, 11431.142664300045, 11437.142214334124, 48588.51411485981, 48983.0, 48997.755011226145, 49814.50185498098, 50402.0, 61734.0, 61855.38144618676, 63587.364126358145, 64190.0, 64316.03525947021, 12712.382106512447, 13040.087193896336, 13156.079074465079, 13273.66815829612, 13439.629881508534, 14933.775993359892, 15186.620334491727, 15205.588046128145, 15291.311890964711, 15373.615659608598, 13976.860231397555, 14129.434822606981, 14501.927490362481, 14508.637284067561, 14520.709585808436, 13632.795508067586, 13634.0, 14530.564083077525, 14843.332050057557, 14844.480443184437, 13206.141600795918, 13926.721465570834, 14160.929195353958, 14164.716705666035, 14200.502982395567, 9200.631974720936, 9666.854997174907, 10391.0, 10445.477726113815, 10610.416427096583, 9850.950745246228, 10136.493175341351, 11035.117190624891, 11325.377104259016, 11330.263532870336], "value": 7953.220078070857, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 114.0, 130.0, 168.0, 170.0, 115.0, 113.0, 116.0, 116.0], "value": 126.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 106.0, 110.0, 143.0, 111.0, 110.0, 112.0, 131.0, 157.0, 137.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 182.0, 182.0, 182.0, 183.0, 184.0, 184.0, 183.0, 186.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 61.0, 91.0, 60.0, 58.0, 58.0, 59.0, 75.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 70.0, 85.0, 68.0, 71.0, 68.0, 82.0, 68.0, 68.0, 82.0], "value": 74.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 88.0, 88.0, 87.0, 84.0, 88.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 91.0, 117.0, 106.0, 88.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 93.0, 84.0, 83.0, 83.0, 83.0, 86.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 60.0, 61.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 57.0, 64.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 87.0, 80.0, 80.0, 83.0, 82.0, 80.0, 77.0, 81.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 144.0, 134.0, 131.0, 134.0, 156.0, 140.0, 192.0, 162.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 151.0, 208.0, 213.0, 203.0, 162.0, 161.0, 162.0, 162.0, 164.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 65.0, 76.0, 75.0, 79.0, 76.0, 62.0], "value": 68.8, "unit": "score"}]}]} 10:44:50 INFO - Return code: 0 10:44:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:44:51 INFO - # TBPL SUCCESS # 10:44:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:44:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:44:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:44:51 INFO - 2017-04-21 10:44:51.083 screenresolution[1657:9842] starting screenresolution argv=screenresolution get 10:44:51 INFO - 2017-04-21 10:44:51.085 screenresolution[1657:9842] Display 0: 1600x1200x32@60 10:44:51 INFO - 2017-04-21 10:44:51.091 screenresolution[1658:9845] starting screenresolution argv=screenresolution list 10:44:51 INFO - Available Modes on Display 0 10:44:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:44:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:44:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:44:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:44:51 INFO - Intel Iris: 10:44:51 INFO - Chipset Model: Intel Iris 10:44:51 INFO - Type: GPU 10:44:51 INFO - Bus: Built-In 10:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 10:44:51 INFO - Vendor: Intel (0x8086) 10:44:51 INFO - Device ID: 0x0a2e 10:44:51 INFO - Revision ID: 0x0009 10:44:51 INFO - Displays: 10:44:51 INFO - Display: 10:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:44:51 INFO - Display Serial Number: 1600x1200 60 10:44:51 INFO - Main Display: Yes 10:44:51 INFO - Mirror: Off 10:44:51 INFO - Online: Yes 10:44:51 INFO - Rotation: Supported 10:44:51 INFO - Return code: 0 10:44:51 INFO - Running post-action listener: _resource_record_post_action 10:44:51 INFO - [mozharness: 2017-04-21 17:44:51.326472Z] Finished run-tests step (success) 10:44:51 INFO - Running post-run listener: _resource_record_post_run 10:44:51 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38237184; Write bytes: 422452224; Read time: 245; Write time: 1384 10:44:51 INFO - TinderboxPrint: CPU usage
54.0% 10:44:51 INFO - TinderboxPrint: I/O read bytes / time
38,237,184 / 245 10:44:51 INFO - TinderboxPrint: I/O write bytes / time
422,452,224 / 1,384 10:44:51 INFO - TinderboxPrint: CPU idle
2,194.8 (46.0%) 10:44:51 INFO - TinderboxPrint: CPU system
951.9 (19.9%) 10:44:51 INFO - TinderboxPrint: CPU user
1,627.0 (34.1%) 10:44:51 INFO - TinderboxPrint: Swap in / out
160,096,256 / 0 10:44:51 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123111936; Write bytes: 124860416; Read time: 11067; Write time: 286 10:44:51 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34264064; Write bytes: 296190976; Read time: 218; Write time: 1091 10:44:51 INFO - Running post-run listener: _upload_blobber_files 10:44:51 INFO - Blob upload gear active. 10:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:44:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:44:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:53 INFO - (blobuploader) - INFO - Done attempting. 10:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:54 INFO - (blobuploader) - INFO - Done attempting. 10:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:55 INFO - (blobuploader) - INFO - Done attempting. 10:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:57 INFO - (blobuploader) - INFO - Done attempting. 10:44:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:44:57 INFO - Return code: 0 10:44:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:44:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:44:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8340ac6247ba5c3573aadf82161ef94a1673dd6f9272f1e6104560c497e0f0ebda8083c31891f85915aba21997fa0bb365d3e432e3ea86fe5e689b1039b94299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/340c6a35160e41385516c02dca39d034cb31fef636d35154e686f9404bf0596f609704d28c1749c5b1cf6d8fa3f3a42314e904568405d8936a200ddbb96bfb82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94541aed736866fe357be280f8f1abbb59b1b077c707cfa0287b971be79bb74b163a72522657e7d6acd3804ee726814ef3fd40218081f0f5f58e63fd95b0eda0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fea7015aa0bd0fe9d7d51b97d760cfeaace0a4d657c8f53dcfd81acc2a8a561fa41588edf73e7aca8ff94e14a5804e975ac1d4745b4769b5c7c7357435cc89a2"} 10:44:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:44:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:44:57 INFO - Contents: 10:44:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8340ac6247ba5c3573aadf82161ef94a1673dd6f9272f1e6104560c497e0f0ebda8083c31891f85915aba21997fa0bb365d3e432e3ea86fe5e689b1039b94299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/340c6a35160e41385516c02dca39d034cb31fef636d35154e686f9404bf0596f609704d28c1749c5b1cf6d8fa3f3a42314e904568405d8936a200ddbb96bfb82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94541aed736866fe357be280f8f1abbb59b1b077c707cfa0287b971be79bb74b163a72522657e7d6acd3804ee726814ef3fd40218081f0f5f58e63fd95b0eda0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fea7015aa0bd0fe9d7d51b97d760cfeaace0a4d657c8f53dcfd81acc2a8a561fa41588edf73e7aca8ff94e14a5804e975ac1d4745b4769b5c7c7357435cc89a2"} 10:44:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:44:57 INFO - Copying logs to upload dir... 10:44:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:44:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.906568 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-21 10:44:57.464937) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:44:57.468359) ========= 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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/8340ac6247ba5c3573aadf82161ef94a1673dd6f9272f1e6104560c497e0f0ebda8083c31891f85915aba21997fa0bb365d3e432e3ea86fe5e689b1039b94299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/340c6a35160e41385516c02dca39d034cb31fef636d35154e686f9404bf0596f609704d28c1749c5b1cf6d8fa3f3a42314e904568405d8936a200ddbb96bfb82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94541aed736866fe357be280f8f1abbb59b1b077c707cfa0287b971be79bb74b163a72522657e7d6acd3804ee726814ef3fd40218081f0f5f58e63fd95b0eda0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fea7015aa0bd0fe9d7d51b97d760cfeaace0a4d657c8f53dcfd81acc2a8a561fa41588edf73e7aca8ff94e14a5804e975ac1d4745b4769b5c7c7357435cc89a2"} build_url:https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010948 build_url: 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8340ac6247ba5c3573aadf82161ef94a1673dd6f9272f1e6104560c497e0f0ebda8083c31891f85915aba21997fa0bb365d3e432e3ea86fe5e689b1039b94299", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/340c6a35160e41385516c02dca39d034cb31fef636d35154e686f9404bf0596f609704d28c1749c5b1cf6d8fa3f3a42314e904568405d8936a200ddbb96bfb82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/94541aed736866fe357be280f8f1abbb59b1b077c707cfa0287b971be79bb74b163a72522657e7d6acd3804ee726814ef3fd40218081f0f5f58e63fd95b0eda0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fea7015aa0bd0fe9d7d51b97d760cfeaace0a4d657c8f53dcfd81acc2a8a561fa41588edf73e7aca8ff94e14a5804e975ac1d4745b4769b5c7c7357435cc89a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:44:57.502861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:44:57.503369) ========= 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.Y4xHxT5aYj/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.aR91RM9WO8/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.005126 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:44:57.551862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:44:57.552188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:44:57.552531) ========= ========= Total master_lag: 0.29 =========