builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0220 starttime: 1486143922.54 results: success (0) buildid: 20170203075709 builduid: 800cee2a0ada4116adb8664e805f322a revision: ff56de0ee8dc01c99e4919b626f8a3c339aca01f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 09:45:22.540517) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 09:45:22.540936) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2017-02-03 09:45:22.541601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 6 secs) (at 2017-02-03 09:45:29.235817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-02-03 09:45:29.240243) ========= 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.elxjlcUixr/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.46AQcX2Sry/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-02-03 09:45:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2017-02-03 09:45:29 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.380174 ========= master_lag: 4.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-02-03 09:45:34.233095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 09:45:34.236442) ========= 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.elxjlcUixr/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.46AQcX2Sry/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.026832 ========= master_lag: 1.55 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 09:45:35.815646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-02-03 09:45:35.815994) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ff56de0ee8dc01c99e4919b626f8a3c339aca01f --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 ff56de0ee8dc01c99e4919b626f8a3c339aca01f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.elxjlcUixr/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.46AQcX2Sry/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-02-03 09:45:35,933 truncating revision to first 12 chars 2017-02-03 09:45:35,933 Setting DEBUG logging. 2017-02-03 09:45:35,933 attempt 1/10 2017-02-03 09:45:35,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ff56de0ee8dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 09:45:37,549 unpacking tar archive at: mozilla-beta-ff56de0ee8dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.889637 ========= master_lag: 4.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2017-02-03 09:45:41.946300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 09:45:41.946597) ========= script_repo_revision: ff56de0ee8dc01c99e4919b626f8a3c339aca01f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 09:45:41.946982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 09:45:41.950261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 09:45:42.118337) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-03 09:45:42.118611) ========= /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.elxjlcUixr/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.46AQcX2Sry/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:45:42 INFO - MultiFileLogger online at 20170203 09:45:42 in /builds/slave/test 09:45: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 09:45:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:42 INFO - {'append_to_log': False, 09:45:42 INFO - 'base_work_dir': '/builds/slave/test', 09:45:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:45:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:42 INFO - 'branch': 'Mozilla-Beta', 09:45:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:42 INFO - 'config_files': ('talos/mac_config.py',), 09:45:42 INFO - 'default_actions': ('clobber', 09:45:42 INFO - 'read-buildbot-config', 09:45:42 INFO - 'download-and-extract', 09:45:42 INFO - 'populate-webroot', 09:45:42 INFO - 'create-virtualenv', 09:45:42 INFO - 'install', 09:45:42 INFO - 'run-tests'), 09:45:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:42 INFO - 'download_minidump_stackwalk': True, 09:45:42 INFO - 'download_symbols': 'ondemand', 09:45:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:42 INFO - 'installer_path': 'installer.exe', 09:45:42 INFO - 'log_level': 'info', 09:45:42 INFO - 'log_name': 'talos', 09:45:42 INFO - 'log_to_console': True, 09:45:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:45:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:45:42 INFO - 'opt_config_files': (), 09:45:42 INFO - 'pip_index': False, 09:45:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:45:42 INFO - 'cmd': ('bash', 09:45:42 INFO - '-c', 09:45:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:45:42 INFO - 'enabled': True, 09:45:42 INFO - 'halt_on_failure': False, 09:45:42 INFO - 'name': 'check_screen_resolution'},), 09:45:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:45:42 INFO - 'cmd': ('bash', 09:45:42 INFO - '-c', 09:45:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:45:42 INFO - 'enabled': True, 09:45:42 INFO - 'halt_on_failure': False, 09:45:42 INFO - 'name': 'check_screen_resolution'},), 09:45:42 INFO - 'run_cmd_checks_enabled': True, 09:45:42 INFO - 'sps_profile': False, 09:45:42 INFO - 'sps_profile_interval': 0, 09:45:42 INFO - 'suite': 'dromaeojs', 09:45:42 INFO - 'system_bits': '32', 09:45:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:42 INFO - 'title': 't-yosemite-r7-0220', 09:45:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:42 INFO - 'use_talos_json': True, 09:45:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:42 INFO - 'work_dir': 'build'} 09:45:42 INFO - [mozharness: 2017-02-03 17:45:42.338393Z] Running clobber step. 09:45:42 INFO - Running pre-action listener: _resource_record_pre_action 09:45:42 INFO - Running main action method: clobber 09:45:42 INFO - rmtree: /builds/slave/test/build 09:45:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:44 INFO - Running post-action listener: _resource_record_post_action 09:45:44 INFO - [mozharness: 2017-02-03 17:45:44.841001Z] Finished clobber step (success) 09:45:44 INFO - [mozharness: 2017-02-03 17:45:44.841126Z] Running read-buildbot-config step. 09:45:44 INFO - Running pre-action listener: _resource_record_pre_action 09:45:44 INFO - Running main action method: read_buildbot_config 09:45:44 INFO - Using buildbot properties: 09:45:44 INFO - { 09:45:44 INFO - "project": "", 09:45:44 INFO - "product": "firefox", 09:45:44 INFO - "script_repo_revision": "production", 09:45:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:45:44 INFO - "repository": "", 09:45:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:45:44 INFO - "buildid": "20170203075709", 09:45:44 INFO - "pgo_build": "False", 09:45:44 INFO - "basedir": "/builds/slave/test", 09:45:44 INFO - "buildnumber": 36, 09:45:44 INFO - "slavename": "t-yosemite-r7-0220", 09:45:44 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:45:44 INFO - "platform": "yosemite_r7", 09:45:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:45:44 INFO - "branch": "mozilla-beta", 09:45:44 INFO - "repo_path": "releases/mozilla-beta", 09:45:44 INFO - "revision": "ff56de0ee8dc01c99e4919b626f8a3c339aca01f", 09:45:44 INFO - "stage_platform": "macosx64", 09:45:44 INFO - "builduid": "800cee2a0ada4116adb8664e805f322a", 09:45:44 INFO - "slavebuilddir": "test" 09:45:44 INFO - } 09:45:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:45:44 INFO - Running post-action listener: _resource_record_post_action 09:45:44 INFO - [mozharness: 2017-02-03 17:45:44.845290Z] Finished read-buildbot-config step (success) 09:45:44 INFO - [mozharness: 2017-02-03 17:45:44.845452Z] Running download-and-extract step. 09:45:44 INFO - Running pre-action listener: _resource_record_pre_action 09:45:44 INFO - Running main action method: download_and_extract 09:45:44 INFO - mkdir: /builds/slave/test/build/tests 09:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:44 INFO - trying https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:45:44 INFO - Downloading https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:45:45 INFO - Downloaded 1165 bytes. 09:45:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:45:45 INFO - Using the following test package requirements: 09:45:45 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:45:45 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:45:45 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:45:45 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:45:45 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:45:45 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:45:45 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:45:45 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:45:45 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:45:45 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:45:45 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:45:45 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:45:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:45:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:45:45 INFO - Fetch https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:45:46 INFO - Http code: 200 09:45:46 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 09:45:46 INFO - x-amz-cf-id: kSG1ZjqKJQhJWdW5WTvvdEZzeay1nPXhVp-aPhowr2jB9wyCge9_Zw== 09:45:46 INFO - x-amz-version-id: ntqgcJVej_aXUhI2WPRGCVt3.E9yTsZB 09:45:46 INFO - Expected file size: 16092043 09:45:46 INFO - Obtained file size: 16092043 09:45:53 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:45:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:45:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:45:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:45:53 INFO - Http code: 200 09:45:53 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 09:45:53 INFO - x-amz-cf-id: YKiqLVPchnayZyqrEbsD1ye2-v3IJcmPjw596ImTXH_unNyG09GJqA== 09:45:53 INFO - x-amz-version-id: ntqgcJVej_aXUhI2WPRGCVt3.E9yTsZB 09:45:54 INFO - Expected file size: 16092043 09:45:54 INFO - Obtained file size: 16092043 09:46:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:46:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:46:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:46:01 INFO - Http code: 200 09:46:01 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 09:46:01 INFO - x-amz-cf-id: XgiafegeMHnbwvtSHygB5iyuNjm6LtU4G1gLoa2LiV1wgpFLqJc8EQ== 09:46:01 INFO - x-amz-version-id: gNYv_EiQLg9iW0SsiVTzCVVrCIMPNiHF 09:46:01 INFO - Expected file size: 14403005 09:46:01 INFO - Obtained file size: 14403005 09:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:02 INFO - trying https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:46:02 INFO - Downloading https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:46:04 INFO - Downloaded 82132983 bytes. 09:46:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:46:04 INFO - mkdir: /builds/slave/test/properties 09:46:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:46:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:46:04 INFO - Contents: 09:46:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:46:05 INFO - Running post-action listener: _resource_record_post_action 09:46:05 INFO - Running post-action listener: set_extra_try_arguments 09:46:05 INFO - [mozharness: 2017-02-03 17:46:05.075028Z] Finished download-and-extract step (success) 09:46:05 INFO - [mozharness: 2017-02-03 17:46:05.075145Z] Running populate-webroot step. 09:46:05 INFO - Running pre-action listener: _resource_record_pre_action 09:46:05 INFO - Running main action method: populate_webroot 09:46:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:46:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:46:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:46:05 INFO - '--tppagecycles', 09:46:05 INFO - '7'], 09:46:05 INFO - 'tests': ['tsvgm']}}, 09:46:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:46:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:46:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:46:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:46:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['damp', 'tps']}, 09:46:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'tests': ['damp', 'tps']}, 09:46:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['dromaeo_dom']}, 09:46:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:46:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['basic_compositor_video']}, 09:46:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:46:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['a11yr', 09:46:05 INFO - 'ts_paint', 09:46:05 INFO - 'tpaint', 09:46:05 INFO - 'sessionrestore', 09:46:05 INFO - 'sessionrestore_no_auto_restore', 09:46:05 INFO - 'tabpaint']}, 09:46:05 INFO - 'other-e10s': {'tests': ['a11yr', 09:46:05 INFO - 'ts_paint', 09:46:05 INFO - 'tpaint', 09:46:05 INFO - 'sessionrestore', 09:46:05 INFO - 'sessionrestore_no_auto_restore', 09:46:05 INFO - 'tabpaint']}, 09:46:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:46:05 INFO - 'ts_paint', 09:46:05 INFO - 'tpaint', 09:46:05 INFO - 'sessionrestore', 09:46:05 INFO - 'sessionrestore_no_auto_restore', 09:46:05 INFO - 'tabpaint']}, 09:46:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:46:05 INFO - 'ts_paint', 09:46:05 INFO - 'tpaint', 09:46:05 INFO - 'sessionrestore', 09:46:05 INFO - 'sessionrestore_no_auto_restore', 09:46:05 INFO - 'tabpaint']}, 09:46:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['a11yr', 09:46:05 INFO - 'ts_paint', 09:46:05 INFO - 'tpaint', 09:46:05 INFO - 'sessionrestore', 09:46:05 INFO - 'sessionrestore_no_auto_restore', 09:46:05 INFO - 'tabpaint']}, 09:46:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['a11yr', 09:46:05 INFO - 'ts_paint', 09:46:05 INFO - 'tpaint', 09:46:05 INFO - 'sessionrestore', 09:46:05 INFO - 'sessionrestore_no_auto_restore', 09:46:05 INFO - 'tabpaint']}, 09:46:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['tsvgx', 09:46:05 INFO - 'tsvgr_opacity', 09:46:05 INFO - 'tart', 09:46:05 INFO - 'tscrollx', 09:46:05 INFO - 'cart']}, 09:46:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:46:05 INFO - 'tsvgr_opacity', 09:46:05 INFO - 'tart', 09:46:05 INFO - 'tscrollx', 09:46:05 INFO - 'cart']}, 09:46:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'talos_options': ['--disable-e10s'], 09:46:05 INFO - 'tests': ['tp5o']}, 09:46:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'tests': ['tp5o']}, 09:46:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'talos_options': ['--disable-e10s', 09:46:05 INFO - '--xperf_path', 09:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:05 INFO - 'tests': ['tp5n']}, 09:46:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:05 INFO - 'talos_options': ['--xperf_path', 09:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:05 INFO - 'tests': ['tp5n']}}, 09:46:05 INFO - 'talos.zip': {'path': '', 09:46:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:05 INFO - Running post-action listener: _resource_record_post_action 09:46:05 INFO - [mozharness: 2017-02-03 17:46:05.094058Z] Finished populate-webroot step (success) 09:46:05 INFO - [mozharness: 2017-02-03 17:46:05.094185Z] Running create-virtualenv step. 09:46:05 INFO - Running pre-action listener: _resource_record_pre_action 09:46:05 INFO - Running main action method: create_virtualenv 09:46:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:46:05 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 09:46:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:46:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:46:05 INFO - Using real prefix '/tools/python27' 09:46:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:46:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:08 INFO - Installing pip.................done. 09:46:08 INFO - Return code: 0 09:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:46:09 INFO - Reading from file tmpfile_stdout 09:46:09 INFO - Output received: 09:46:09 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) 09:46:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:09 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:09 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 09:46:09 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 09:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:09 INFO - 'HOME': '/Users/cltbld', 09:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:09 INFO - 'LOGNAME': 'cltbld', 09:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:09 INFO - 'MOZ_NO_REMOTE': '1', 09:46:09 INFO - 'NO_EM_RESTART': '1', 09:46:09 INFO - 'PAGER': '/bin/cat', 09:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:09 INFO - 'PWD': '/builds/slave/test', 09:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:09 INFO - 'SHELL': '/bin/bash', 09:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:09 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:09 INFO - 'USER': 'cltbld', 09:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:09 INFO - 'XPC_FLAGS': '0x0', 09:46:09 INFO - 'XPC_SERVICE_NAME': '0', 09:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:10 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 09:46:10 INFO - Cleaning up... 09:46:10 INFO - Return code: 0 09:46:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:46:10 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')]} 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:10 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')]} 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:10 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:10 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 09:46:10 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 09:46:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:10 INFO - 'HOME': '/Users/cltbld', 09:46:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:10 INFO - 'LOGNAME': 'cltbld', 09:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:10 INFO - 'MOZ_NO_REMOTE': '1', 09:46:10 INFO - 'NO_EM_RESTART': '1', 09:46:10 INFO - 'PAGER': '/bin/cat', 09:46:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:10 INFO - 'PWD': '/builds/slave/test', 09:46:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:10 INFO - 'SHELL': '/bin/bash', 09:46:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:10 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:10 INFO - 'USER': 'cltbld', 09:46:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:10 INFO - 'XPC_FLAGS': '0x0', 09:46:10 INFO - 'XPC_SERVICE_NAME': '0', 09:46:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:10 INFO - Downloading/unpacking psutil>=3.1.1 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 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 09:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:14 INFO - Installing collected packages: psutil 09:46:14 INFO - Running setup.py install for psutil 09:46:14 INFO - building 'psutil._psutil_osx' extension 09:46:14 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 09:46:15 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 09:46:15 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 09:46:15 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 09:46:15 INFO - building 'psutil._psutil_posix' extension 09:46:15 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 09:46:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:46:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:46:15 INFO - ^ 09:46:15 INFO - 1 warning generated. 09:46:15 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 09:46:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:15 INFO - Successfully installed psutil 09:46:15 INFO - Cleaning up... 09:46:15 INFO - Return code: 0 09:46:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:46:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:15 INFO - 'HOME': '/Users/cltbld', 09:46:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:15 INFO - 'LOGNAME': 'cltbld', 09:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:15 INFO - 'MOZ_NO_REMOTE': '1', 09:46:15 INFO - 'NO_EM_RESTART': '1', 09:46:15 INFO - 'PAGER': '/bin/cat', 09:46:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:15 INFO - 'PWD': '/builds/slave/test', 09:46:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:15 INFO - 'SHELL': '/bin/bash', 09:46:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:15 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:15 INFO - 'USER': 'cltbld', 09:46:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:15 INFO - 'XPC_FLAGS': '0x0', 09:46:15 INFO - 'XPC_SERVICE_NAME': '0', 09:46:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:46:16 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 09:46:16 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 09:46:16 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 09:46:16 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 09:46:16 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 09:46:16 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 09:46:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:46:18 INFO - Installing collected packages: mozsystemmonitor 09:46:18 INFO - Running setup.py install for mozsystemmonitor 09:46:18 INFO - Successfully installed mozsystemmonitor 09:46:18 INFO - Cleaning up... 09:46:18 INFO - Return code: 0 09:46:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:46:18 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')]} 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:18 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')]} 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:18 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:18 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 09:46:18 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 09:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:18 INFO - 'HOME': '/Users/cltbld', 09:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:18 INFO - 'LOGNAME': 'cltbld', 09:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:18 INFO - 'MOZ_NO_REMOTE': '1', 09:46:18 INFO - 'NO_EM_RESTART': '1', 09:46:18 INFO - 'PAGER': '/bin/cat', 09:46:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:18 INFO - 'PWD': '/builds/slave/test', 09:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:18 INFO - 'SHELL': '/bin/bash', 09:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:18 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:18 INFO - 'USER': 'cltbld', 09:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:18 INFO - 'XPC_FLAGS': '0x0', 09:46:18 INFO - 'XPC_SERVICE_NAME': '0', 09:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:19 INFO - Downloading/unpacking jsonschema==2.5.1 09:46:19 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 09:46:19 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 09:46:19 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 09:46:19 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 09:46:19 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 09:46:19 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 09:46:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:46:21 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 09:46:21 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 09:46:21 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 09:46:21 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 09:46:21 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 09:46:21 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 09:46:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:22 INFO - warning: no files found matching '*.txt' 09:46:22 INFO - no previously-included directories found matching 'build' 09:46:22 INFO - no previously-included directories found matching 'dist' 09:46:22 INFO - no previously-included directories found matching '.git*' 09:46:22 INFO - Installing collected packages: jsonschema, functools32 09:46:22 INFO - Running setup.py install for functools32 09:46:22 INFO - warning: no files found matching '*.txt' 09:46:22 INFO - no previously-included directories found matching 'build' 09:46:22 INFO - no previously-included directories found matching 'dist' 09:46:22 INFO - no previously-included directories found matching '.git*' 09:46:22 INFO - Successfully installed jsonschema functools32 09:46:22 INFO - Cleaning up... 09:46:22 INFO - Return code: 0 09:46:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:22 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:22 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 09:46:22 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 09:46:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:22 INFO - 'HOME': '/Users/cltbld', 09:46:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:22 INFO - 'LOGNAME': 'cltbld', 09:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:22 INFO - 'MOZ_NO_REMOTE': '1', 09:46:22 INFO - 'NO_EM_RESTART': '1', 09:46:22 INFO - 'PAGER': '/bin/cat', 09:46:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:22 INFO - 'PWD': '/builds/slave/test', 09:46:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:22 INFO - 'SHELL': '/bin/bash', 09:46:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:22 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:22 INFO - 'USER': 'cltbld', 09:46:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:22 INFO - 'XPC_FLAGS': '0x0', 09:46:22 INFO - 'XPC_SERVICE_NAME': '0', 09:46:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:46:22 INFO - Cleaning up... 09:46:22 INFO - Return code: 0 09:46:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:22 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:22 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 09:46:22 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 09:46:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:22 INFO - 'HOME': '/Users/cltbld', 09:46:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:22 INFO - 'LOGNAME': 'cltbld', 09:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:22 INFO - 'MOZ_NO_REMOTE': '1', 09:46:22 INFO - 'NO_EM_RESTART': '1', 09:46:22 INFO - 'PAGER': '/bin/cat', 09:46:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:22 INFO - 'PWD': '/builds/slave/test', 09:46:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:22 INFO - 'SHELL': '/bin/bash', 09:46:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:22 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:22 INFO - 'USER': 'cltbld', 09:46:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:22 INFO - 'XPC_FLAGS': '0x0', 09:46:22 INFO - 'XPC_SERVICE_NAME': '0', 09:46:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46:25 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 09:46:25 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 09:46:25 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 09:46:25 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 09:46:25 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 09:46:25 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 09:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:26 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 09:46:26 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 09:46:26 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 09:46:26 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 09:46:26 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 09:46:26 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 09:46:27 INFO - Downloading docopt-0.6.1.tar.gz 09:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:27 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:27 INFO - Running setup.py install for blobuploader 09:46:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:27 INFO - Running setup.py install for requests 09:46:27 INFO - Running setup.py install for docopt 09:46:27 INFO - Successfully installed blobuploader requests docopt 09:46:27 INFO - Cleaning up... 09:46:28 INFO - Return code: 0 09:46:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:28 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:28 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 09:46:28 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 09:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:28 INFO - 'HOME': '/Users/cltbld', 09:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:28 INFO - 'LOGNAME': 'cltbld', 09:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:28 INFO - 'MOZ_NO_REMOTE': '1', 09:46:28 INFO - 'NO_EM_RESTART': '1', 09:46:28 INFO - 'PAGER': '/bin/cat', 09:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:28 INFO - 'PWD': '/builds/slave/test', 09:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:28 INFO - 'SHELL': '/bin/bash', 09:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:28 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:28 INFO - 'USER': 'cltbld', 09:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:28 INFO - 'XPC_FLAGS': '0x0', 09:46:28 INFO - 'XPC_SERVICE_NAME': '0', 09:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yfx_Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-_hYdrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mTjthT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5lcUHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VDSqiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-uEO5oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:28 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-DtOJhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lETa5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vialse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gigvE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Wgem5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9DFTQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vtCQJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-a2QILP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ffkJ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-RM7alt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:29 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-eFAoFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:30 INFO - Running setup.py install for manifestparser 09:46:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:30 INFO - Running setup.py install for mozcrash 09:46:30 INFO - Running setup.py install for mozdebug 09:46:30 INFO - Running setup.py install for mozdevice 09:46:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:30 INFO - Running setup.py install for mozfile 09:46:30 INFO - Running setup.py install for mozhttpd 09:46:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:30 INFO - Running setup.py install for mozinfo 09:46:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Running setup.py install for mozInstall 09:46:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Running setup.py install for mozleak 09:46:31 INFO - Running setup.py install for mozlog 09:46:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Running setup.py install for moznetwork 09:46:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:31 INFO - Running setup.py install for mozprocess 09:46:31 INFO - Running setup.py install for mozprofile 09:46:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:32 INFO - Running setup.py install for mozrunner 09:46:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:32 INFO - Running setup.py install for mozscreenshot 09:46:32 INFO - Running setup.py install for moztest 09:46:32 INFO - Running setup.py install for mozversion 09:46:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:32 INFO - Cleaning up... 09:46:32 INFO - Return code: 0 09:46:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:32 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:32 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 09:46:32 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 09:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:32 INFO - 'HOME': '/Users/cltbld', 09:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:32 INFO - 'LOGNAME': 'cltbld', 09:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:32 INFO - 'MOZ_NO_REMOTE': '1', 09:46:32 INFO - 'NO_EM_RESTART': '1', 09:46:32 INFO - 'PAGER': '/bin/cat', 09:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:32 INFO - 'PWD': '/builds/slave/test', 09:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:32 INFO - 'SHELL': '/bin/bash', 09:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:32 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:32 INFO - 'USER': 'cltbld', 09:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:32 INFO - 'XPC_FLAGS': '0x0', 09:46:32 INFO - 'XPC_SERVICE_NAME': '0', 09:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:32 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-LtOGwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-E0rmAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZCQXDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-CPBPXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yMIaN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-FAd4u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-0Vp0cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-94pyBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yJtVsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-2Du6gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:33 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)) 09:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:33 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Ndohnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:34 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)) 09:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-B0SAhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-_LydTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:34 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)) 09:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-QXslx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:34 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)) 09:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Q61BmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:34 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)) 09:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-d0LAVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:34 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)) 09:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:34 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pSrHtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:34 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)) 09:46:34 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)) 09:46:34 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)) 09:46:34 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)) 09:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:37 INFO - Downloading blessings-1.6.tar.gz 09:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:37 INFO - Installing collected packages: blessings 09:46:37 INFO - Running setup.py install for blessings 09:46:37 INFO - Successfully installed blessings 09:46:37 INFO - Cleaning up... 09:46:37 INFO - Return code: 0 09:46:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:37 INFO - Reading from file tmpfile_stdout 09:46:37 INFO - Current package versions: 09:46:37 INFO - blessings == 1.6 09:46:37 INFO - blobuploader == 1.2.4 09:46:37 INFO - docopt == 0.6.1 09:46:37 INFO - functools32 == 3.2.3-2 09:46:37 INFO - jsonschema == 2.5.1 09:46:37 INFO - manifestparser == 1.1 09:46:37 INFO - mozInstall == 1.12 09:46:37 INFO - mozcrash == 1.0 09:46:37 INFO - mozdebug == 0.1 09:46:37 INFO - mozdevice == 0.48 09:46:37 INFO - mozfile == 1.2 09:46:37 INFO - mozhttpd == 0.7 09:46:37 INFO - mozinfo == 0.9 09:46:37 INFO - mozleak == 0.1 09:46:37 INFO - mozlog == 3.4 09:46:37 INFO - moznetwork == 0.27 09:46:37 INFO - mozprocess == 0.23 09:46:37 INFO - mozprofile == 0.28 09:46:37 INFO - mozrunner == 6.13 09:46:37 INFO - mozscreenshot == 0.1 09:46:37 INFO - mozsystemmonitor == 0.3 09:46:37 INFO - moztest == 0.8 09:46:37 INFO - mozversion == 1.4 09:46:37 INFO - psutil == 3.1.1 09:46:37 INFO - requests == 1.2.3 09:46:37 INFO - wsgiref == 0.1.2 09:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:37 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:37 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 09:46:37 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 09:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:37 INFO - 'HOME': '/Users/cltbld', 09:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:37 INFO - 'LOGNAME': 'cltbld', 09:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:37 INFO - 'MOZ_NO_REMOTE': '1', 09:46:37 INFO - 'NO_EM_RESTART': '1', 09:46:37 INFO - 'PAGER': '/bin/cat', 09:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:37 INFO - 'PWD': '/builds/slave/test', 09:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:37 INFO - 'SHELL': '/bin/bash', 09:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:37 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:37 INFO - 'USER': 'cltbld', 09:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:37 INFO - 'XPC_FLAGS': '0x0', 09:46:37 INFO - 'XPC_SERVICE_NAME': '0', 09:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 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)) 09:46:38 INFO - Cleaning up... 09:46:38 INFO - Return code: 0 09:46:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:38 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 0x1095e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10955e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f2bc90c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, '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.elxjlcUixr/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.46AQcX2Sry/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 09:46:38 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 09:46:38 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 09:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:38 INFO - 'HOME': '/Users/cltbld', 09:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:38 INFO - 'LOGNAME': 'cltbld', 09:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:38 INFO - 'MOZ_NO_REMOTE': '1', 09:46:38 INFO - 'NO_EM_RESTART': '1', 09:46:38 INFO - 'PAGER': '/bin/cat', 09:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:38 INFO - 'PWD': '/builds/slave/test', 09:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:38 INFO - 'SHELL': '/bin/bash', 09:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:46:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:38 INFO - 'USER': 'cltbld', 09:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:38 INFO - 'XPC_FLAGS': '0x0', 09:46:38 INFO - 'XPC_SERVICE_NAME': '0', 09:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:46:38 INFO - Cleaning up... 09:46:38 INFO - Return code: 0 09:46:38 INFO - Running post-action listener: _resource_record_post_action 09:46:38 INFO - Running post-action listener: _start_resource_monitoring 09:46:38 INFO - Starting resource monitoring. 09:46:38 INFO - [mozharness: 2017-02-03 17:46:38.495266Z] Finished create-virtualenv step (success) 09:46:38 INFO - [mozharness: 2017-02-03 17:46:38.496264Z] Running install step. 09:46:38 INFO - Running pre-action listener: _resource_record_pre_action 09:46:38 INFO - Running main action method: install 09:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:38 INFO - Reading from file tmpfile_stdout 09:46:38 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:46:38 INFO - Reading from file tmpfile_stdout 09:46:38 INFO - Output received: 09:46:38 INFO - Usage: mozinstall [options] installer 09:46:38 INFO - Options: 09:46:38 INFO - -h, --help show this help message and exit 09:46:38 INFO - -d DEST, --destination=DEST 09:46:38 INFO - Directory to install application into. [default: 09:46:38 INFO - "/builds/slave/test"] 09:46:38 INFO - --app=APP Application being installed. [default: firefox] 09:46:38 INFO - mkdir: /builds/slave/test/build/application 09:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:47:00 INFO - Reading from file tmpfile_stdout 09:47:00 INFO - Output received: 09:47:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:47:00 INFO - Running post-action listener: _resource_record_post_action 09:47:00 INFO - [mozharness: 2017-02-03 17:47:00.566335Z] Finished install step (success) 09:47:00 INFO - [mozharness: 2017-02-03 17:47:00.566498Z] Running run-tests step. 09:47:00 INFO - Running pre-action listener: _resource_record_pre_action 09:47:00 INFO - Running main action method: run_tests 09:47:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:47:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:47:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:47:00 INFO - 2017-02-03 09:47:00.581 screenresolution[1624:7363] starting screenresolution argv=screenresolution get 09:47:00 INFO - 2017-02-03 09:47:00.584 screenresolution[1624:7363] Display 0: 1600x1200x32@60 09:47:00 INFO - 2017-02-03 09:47:00.589 screenresolution[1625:7365] starting screenresolution argv=screenresolution list 09:47:00 INFO - Available Modes on Display 0 09:47:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:47:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:47:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:47:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:47:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:47:00 INFO - Intel Iris: 09:47:00 INFO - Chipset Model: Intel Iris 09:47:00 INFO - Type: GPU 09:47:00 INFO - Bus: Built-In 09:47:00 INFO - VRAM (Dynamic, Max): 1536 MB 09:47:00 INFO - Vendor: Intel (0x8086) 09:47:00 INFO - Device ID: 0x0a2e 09:47:00 INFO - Revision ID: 0x0009 09:47:00 INFO - Displays: 09:47:00 INFO - Display: 09:47:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:47:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:47:00 INFO - Display Serial Number: 1600x1200 60 09:47:00 INFO - Main Display: Yes 09:47:00 INFO - Mirror: Off 09:47:00 INFO - Online: Yes 09:47:00 INFO - Rotation: Supported 09:47:00 INFO - Return code: 0 09:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:00 INFO - Python 2.7.3 09:47:00 INFO - Return code: 0 09:47:00 INFO - grabbing minidump binary from tooltool 09:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:00 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 0x1093fcd30>, '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 0x109262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093f4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:00 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 09:47:00 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 09:47:00 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 09:47:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:00 INFO - Return code: 0 09:47:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:47:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:47:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:00 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/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 09:47:00 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/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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 09:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.elxjlcUixr/Render', 09:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:00 INFO - 'HOME': '/Users/cltbld', 09:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:00 INFO - 'LOGNAME': 'cltbld', 09:47:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:00 INFO - 'MOZ_NO_REMOTE': '1', 09:47:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:00 INFO - 'NO_EM_RESTART': '1', 09:47:00 INFO - 'PAGER': '/bin/cat', 09:47:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:00 INFO - 'PWD': '/builds/slave/test', 09:47:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:00 INFO - 'SHELL': '/bin/bash', 09:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.46AQcX2Sry/Listeners', 09:47:00 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 09:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:00 INFO - 'USER': 'cltbld', 09:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:00 INFO - 'XPC_FLAGS': '0x0', 09:47:00 INFO - 'XPC_SERVICE_NAME': '0', 09:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:00 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/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 09:47:01 INFO - mozversion application_buildid: 20170203075709 09:47:01 INFO - mozversion application_changeset: ff56de0ee8dc01c99e4919b626f8a3c339aca01f 09:47:01 INFO - mozversion application_display_name: Firefox 09:47:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:01 INFO - mozversion application_name: Firefox 09:47:01 INFO - mozversion application_remotingname: firefox 09:47:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:01 INFO - mozversion application_vendor: Mozilla 09:47:01 INFO - mozversion application_version: 52.0 09:47:01 INFO - mozversion platform_buildid: 20170203075709 09:47:01 INFO - mozversion platform_changeset: ff56de0ee8dc01c99e4919b626f8a3c339aca01f 09:47:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:01 INFO - mozversion platform_version: 52.0 09:47:01 INFO - using testdate: 1486144021 09:47:01 INFO - actual date: 1486144021 09:47:01 INFO - starting webserver on 'localhost:49236' 09:47:01 INFO - SUITE-START | Running 2 tests 09:47:01 INFO - TEST-START | dromaeo_css 09:47:01 INFO - operating with platform_type : mac_ 09:47:01 INFO - Initialising browser for dromaeo_css test... 09:47:01 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpxSE9cA/profile http://localhost:49236/getInfo.html) 09:47:03 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:47:03 INFO - PROCESS | 1635 | colorDepth:24 09:47:03 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:47:03 INFO - PROCESS | 1635 | __metrics 09:47:03 INFO - PROCESS | 1635 | 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" 09:47:03 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:04 INFO - TEST-INFO | 1635: exit 0 09:47:04 INFO - Browser initialized. 09:47:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:04 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpxSE9cA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:16 INFO - PROCESS | 1638 | RSS: Main: 168337408 09:47:16 INFO - PROCESS | 1638 | 09:50:20 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 09:50:22 INFO - PROCESS | 1638 | RSS: Main: 312246272 09:50:22 INFO - PROCESS | 1638 | 09:53:24 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 09:53:25 INFO - PROCESS | 1638 | RSS: Main: 296050688 09:53:25 INFO - PROCESS | 1638 | 09:56:27 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 09:56:28 INFO - PROCESS | 1638 | RSS: Main: 270622720 09:56:28 INFO - PROCESS | 1638 | 09:59:30 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 09:59:31 INFO - PROCESS | 1638 | RSS: Main: 268910592 09:59:31 INFO - PROCESS | 1638 | 10:02:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:02:35 INFO - PROCESS | 1638 | RSS: Main: 256983040 10:02:35 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:05:38 INFO - PROCESS | 1638 | RSS: Main: 424259584 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | __start_tp_report 10:05:38 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:05:38 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:05:38 INFO - PROCESS | 1638 | |i|pagename|runs| 10:05:38 INFO - PROCESS | 1638 | |0;dojo.html;3449.6032956210033;3480.860765569377;3482.7736197147183;3514.3674138655033;3549.8580056797728;5640.238567793347;5694.060480020797;5725.169850371693;5740.397258287877;5755.5971082024325;5707.14392841074;5815.447532484418;5831.183634291203;5839.591228613988;5850.385709500505;5214.139666954958;5259.2899958505495;5260.368755749297;5300.284461597674;5337.67973921564;5245.31810864589;5248.396434410034;5253.290805741233;5261.158214685651;5286.10136276832;4358.803853826569;5312.150055991042;5319.601029922752;5336.359636843584;5385.434529374418;5330.200469929503;5334.359876814788;5342.385625653022;5343.839684809482;5398.433164517708;5093.898122037538;5190.377154741455;5259.894802103975;5276.2085687146855;5280.577553795687;5717.285339332583;5725.141228815669;5751.309842818847;5781.364049954544;5784.95870743266;6182.721777520022;6186.938130618726;6219.937800621981;6275.24697036354;6279.7174127163935;5242.449542797989;6252.343503932113;6292.119103325538;6299.086632438317;6323.272823625296;5946.643201407886;5974.2830860297045;5997.370276120944;5998.520118390518;6009.879802403927;6227.501799856001;6238.656873871981;6337.33457986914;6339.936600633934;6344.206974128234;5493.340799104133;6127.3566275540425;6146.678464130234;6275.341089185661;6285.811425657238;6279.152314437584;6299.464545513591;6304.18045654062;6322.9051564226575;6344.175257216532;6127.6782420562195;6162.506999440124;6162.5378096642935;6274.341194174637;6289.213848268966;6221.906671399933;6258.3428739982555;6273.215848018997;6279.309275979638;6289.496840252768;4963.45402005779;5033.245013247969;5039.4708555601865;5044.192929131322;5058.367704036996;4459.175052615276;4469;4506.324051392252;4539.205639013159;4547.522510136454;5692.857678557986;5768.134779783066;5786.652800831964;5798.710064496842;5823.708814559255;5553.444655534495;6259.937400626027;6262.248530176408;6263.6241825490615;6285.182926219562;5860.882782344329;5875.20684707559;5877.000909845251;5878.588498805128;5893.3222679391565;5422.783088676488;5445.074337362578;5449.4005659377435;5509.146082357241;5514.641548299348;6396.360363963567;6402.1357116790505;6420.6147631142285;6433.131527243762;6448.355164483514;6268;6278.215223097113;6284.5600807943;6297.559170857996;6313.621182729051;4804.73573953422;6225.128482012431;6319.715612797343;6340.175777149126;6385;6202.503799695924;6230.408111229426;6253.249610046823;6272.121902933502;6278.372162783685;6238.6880655967925;6257.0614407837365;6273.121762953099;6282.748690052346;6286.402791734778;6104.816855494165;6139.8601398601395;6180.567360284737;6213.130161777264;6235.438810507076;6119.959572021022;6143.296949342275;6187.257529096537;6266.185395898504;6277.435030847246;6133.44798968095;6139.938600613937;6160.9691951541745;6167.660778657217;6196.907046394217;6056.9091463628965;6222.502199824094;6228.532860035425;6241.3134555197985;6274.749010039547;4773.522647735199;5918.496927761016;5956.106584012433;6073.362296958756;6147.047207682816 10:05:38 INFO - PROCESS | 1638 | |1;ext.html;482.2525086116519;504.51818513319785;531.4897698209719;531.5322516185756;537.3551737914504;30877.845610771972;32802.50796238055;40435.99999999996;41139.38290925631;41308.58691413085;42899.571004290025;43291.701248962505;43305;43432.782836085775;43467.130657386835;9574.234061275116;9723.12491875731;9750.853737193947;9751.17115045222;9757.609695612167;8975.192232699055;9130;9130.086991300883;9286.257099432063;9590.280728945358;9098.454092754422;11643.592474263403;11860.64418067455;11884.702882427922;12098;9743.658971935949;11687.357195354252;11706.648800535997;11776.470058847286;11783.293002419796;11677.649670509898;11761.764764704743;11777.293362398283;11778.587749428729;11779.764404711857;40123.996900077436;40417.59582404197;40423.7978810107;40427.797861010506;40463.78608641746;3389.5254664347012;3402.0304213299337;3549.7692649977926;3662.8351724172476;3773.3585290500682;22767;29396.41207175866;29457.821687132488;30367.848160759055;30875.073747787377;3208.8876889308763;3314.552535407737;3328.9667103328898;3435.381631306364;3444.070101072721;494391;497856;498608.5208721872;499465;500392;27847.86076069607;33863.49204761931;59368;59815.70092149598;59873;35799.82100089483;35825.64174358223;35884.64115358865;35933.64066359355;36026;14950.476733314283;15110.773338399933;15128.924355378373;15135.091894486146;15147;12775.61673149807;12866.935665321613;12875.420606072561;12884.033697472727;12929;7499.737509187262;7624.19945905683;7917.722879699183;7918.2477664621765;8006.799830004296;3280.6063272407464;3355.3624811286268;3367.326534693071;3379.729621630264;3381.2223188666744;983.8081574092984;1029.0789743179812;1069.9679009629724;1091.93994330311;1095.5562996986234;23548.764512355;29445;29595.704042959725;29915.551266731018;29969.40061198764;995.5221493683073;1063.3460421840512;1087.244365166202;1138.4364739453858;1254.0657210378145;15149.242537873062;15440.764738820868;15446.227688615525;15476.380944762308;15866.52400427989;663893;670726;671015;671428;672362;50135.74932125316;50996.745016275425;51832;51955;57623.98316058918;1324.8145259663654;1376;1416.2140012293276;1419.9989007749512;1420.2401715082588;30006.24984375321;30636;30778.538321925636;30824;31255.06234812959;49170.26244606405;49628.51114466572;49695;49742.751286243336;49755.502444975085;563172;567436;622176;639118;738420;25577.488450231263;25649.615255770805;25894.482110357312;26146.215613530865;26185.73814261909;44534.77732611316;44596.43228541644;44711.329330060726;44894.102117958115;44977.55022449734;36531;37090;37405;37500.43749343816;37562.62437375591;36686.26627467489;36841.65863836682;36971.815140924125;37593.060173495884;37876.62123378841;36605.70548650634;36664.81667591645;37196.07009824776;37282.440763388026;37571;31876.521852171772;33736.83131584425;33819.15452113618;33979.98060058202;34113.31773364469;24803.62794558047;25171.622425663263;25279.87360063188;25662;25754.742452575236 10:05:38 INFO - PROCESS | 1638 | |2;jquery.html;378.6062495005194;382.724438404349;390.65011101386057;394.587655899585;414.66205042890044;14385.784213236784;17706.82293177068;20544;21656.89171554142;21705.891470542643;20878.686819697716;20954.37136885892;21101.733895966252;21137.47156321093;21273;5677.120046392805;6109.908351374733;6159.722812473427;6166.81499555014;6176.135341052256;5876.353601103875;6053.334133245339;6090.299615544225;6116.7553297868035;6164.167837341969;5803.187553742479;6052.425019623129;6060.363661815512;6063.151158837766;6066.605670631417;5790.218320526717;6003.639781613074;6049.66726830022;6056.848578785522;6086.02623580225;5319.787208511655;5325.467453254682;5325.840224793224;5327.786888524454;5337.70642614656;25120.371990700194;26178.6073208902;26230.475390492273;26393.472130557282;26537.336566585796;1972.8421726261865;2199.802017818388;2357.6817129687443;2421.0073869713333;2478.876056197201;15590.610234744108;16137.273822678007;16244.918775406166;16274.75587866183;16569.751453728204;1890.5273681579606;1927.1905799564217;1943.9416817495498;1944.4944314478196;2018.7476565429322;115847.4207628965;117131.07172320675;120432.39783801112;121311.99999999911;121448;9682;10516.948305169575;10897.182711296684;11453.71365715847;11642.592509262135;12685.619431417072;13404.865951340362;14340.21128837924;14367;14372.784408233885;7240.348368646847;7634.923650763421;8230.753077407688;8746.431481953652;8852.070532594114;8896.909226331807;8930.285577153812;8944.01615822259;9072;9161.17549420542;5940.019896716994;6259.873222819936;6810.216825065082;6970.616616086164;6973.163220413583;1791.2566284991842;1810.1311370542214;1871.990640046791;1891.9810801892081;1907.513584036062;887.7425546591417;971.6793458158791;993.7416271769248;1033.4161198922734;1044.984325235122;21353.707900753085;21579.880622362205;21905.207514111473;22025.00887460068;22196.556068878534;982.4007355513131;982.832918403873;1009.5961615353771;1015.9441230732233;1031.9484025798681;8271.296939760068;11242;11683.240589361665;11754.471048802825;11772.17594768375;600337.9983100144;605539;606465;621667;622522;108699;109818;116190.41904790422;117326.41336793432;120038.3998080004;861.4874149880811;997.3467378866853;1045.231754660324;1054.9156067514427;1063.984040239397;15138.470153545013;18560.607954403742;18829.529261768566;19247.230110795972;19839.801601983796;55578.72210638921;57860.4213957855;58412.95554655567;58478;59037.114443282524;58399.124013138986;81319.18680813115;81902;82812.75780863171;84328.51864628779;8013.439059265796;8228.588570571566;8394.622241999246;8529.701460448854;8589;9321.766955826159;12701.110922235355;12766.936165319114;12783.80824287655;13129.934350328569;10869.29349592274;11204.327740335606;11271.774564508827;11397.373144476802;11402.372869492257;10874.34753914736;10936.562537498728;11000.22998390137;11371.886281137413;11382.943085284853;11177.329360238411;11216.775664486828;11688.357140357022;11718.824217636571;11756.823647645464;6286.905696414649;7325.974363588995;7587.8997545356715;8132.959335203286;8419;9789.363691360039;9869.111779939552;10872.021518063413;11197.72005699864;11549.307041577533 10:05:38 INFO - PROCESS | 1638 | |3;mootools.html;1297.506947360003;1376.0505251376555;1543.2360981314248;1700.9149542522878;1925.9807401925978;7659.1574926758085;8064.193580641941;8324.916750832483;8552.828943421127;8561.743147705578;8439.57802109895;8500.489970601768;8506.447080939735;8545.871811922827;8553.230209281164;2011.3764732932764;2354.5290941811622;2410.0721222329444;2410.963835542468;2413.8431001984904;2377.738448770634;2434.1358817619666;2435.6468312094735;2436.5502525997003;2439.6828412306377;2373.905043798246;2383.249276477904;2401.771831675988;2405.458771776345;2410.758924107593;2348.8825558721996;2366.0890557135453;2388.7611238876148;2392.114917480526;2395.2574701842395;2350.576896158691;2373.4422410733464;2414.9034038638433;2418.600930846408;2418.8790560471907;8496.490210587384;8534.274586660142;8583.871241931314;8600.8709869352;8611.311095112376;5198.064348417283;5375.220593013991;5376.704281264529;5388.838334849961;5392.78428862845;3484.407650699387;3618.6381361863864;3677.687396571295;3681.650243226889;3698;1098.3355070182583;1107.479484642217;1120.9943950280197;1143.1369316166324;1144.2962578014544;11018.724531886686;11025.944870275678;11104.666859994213;11107;11160.274582152135;4355.912881742347;4501.189785838515;4602.88492787683;4604.033153037833;4615.723056616614;8743.825123497621;8749.91250087491;8754.737357879274;8759.386842920934;8769;4322.243607368698;5242.397124330674;5244.659097158673;5252.973735131376;5258;4358.21552120615;4472.284434490466;4488;4606.539346065367;4958.925616115761;3783.45139954705;3802.980985095057;3851.595582463801;3861.961380386216;3865.6714179294513;1156.7570810129967;1159.2812456276993;1163.5462169753803;1175.623800383869;1176.7293522489874;780.449782903052;848.4866655673352;882.2853488674194;936.6628013914985;937.9484128372868;4979.45226025137;5679.801206957736;5789;5875.9118613220835;5945.524358051345;781.5506084001722;889.822035592884;934.1265916368218;935.6304259817471;945.7257395355407;3685.355062863988;3725.8695945642316;3787;3880.689544836406;3915.941260881089;9642.566084526214;10301.9484902575;10388.117010054078;10393.792124157626;10403.739906502247;10234.437105959243;10335.534900929326;10342.37945723259;10348.637797677045;10408.687739367831;6582.275949645536;8109.189081091961;8177.795555111051;8188.549629770419;8192.631331590093;5655.406182350794;5665.801696940587;5717.485426311486;5882.764689412375;5896.292444906639;9566.139047485482;9684.85472717924;9694.321397502106;9709.417434953926;9726.854097188689;9022.593983270637;9326.347155699035;9567.330286879851;9803.411795292306;9823.508824558887;6736.7642132525125;6833.89749153773;6910.7581234656545;6918.5502942308585;6995.860082798417;8160.877586836321;8174.509529428254;8237.393708226838;8243.381746369167;8271.503709777433;7214.927850721426;7304.19653838088;7347.155077166194;7397;7450.8509829802015;7180.389666878374;7206.207317195209;7243.348098671145;7249.166345870292;7281.308275713799;6646.368594983469;6739.59562426256;6832.658367081725;6900.447964162755;6910.8617827644175;4295.269804133242;4356.695031347902;4734.526547345238;4753.0256297458245;4793.736344500946;4512.120136573337;4547.226971414933;4625.583697467109;4965.577925876197;5053.090443720019 10:05:38 INFO - PROCESS | 1638 | |4;prototype.html;271.8912435025989;285.858500042479;312.4812810734181;320.29055641753513;322.57903436016016;5352.91970620441;5381.865453363668;5396.703181325035;5421.728913554326;5421.837344879655;5328.413874473805;5328.600354973383;5332.493413125757;5403.541388668156;5406.513413792758;3933.2330195611867;3947.269755095302;3953.8418463261505;4069.8197522718374;4173.394857745625;3705.277046173542;4091.3862920561855;4154.086101057763;4179.498460184782;4196.643285320736;3808.1622043150464;4051.3112770828884;4076.7961601919787;4098.262312783698;4117.899871065763;3539.557555305587;3888.7083468739957;4008.83964641414;4140.8964775880695;4156.771377574248;3061.0204734484973;3422.435298175798;3493.94759078614;3496.4405695088662;3535.3636345457808;5250.65870718402;5267.499587539178;5272.57819374453;5280.419153893069;5333.493318134771;4506.684532082755;4631.633668067928;4685.109829132454;4689.507601701806;4706.1999460091865;5156.149235376159;5565.9443405566235;5665.2351932489;5674.340050667338;5702.800401985952;3486.3724529584665;3921.607839216084;3933.272344616255;3934.547527034399;3944.9408258876138;5719.739748343446;5996.192417814632;6041.909371359433;6054.545909056838;6077.7568897244055;3052.069118918707;3895.474110995036;3929.2730844793805;3940.7832569208394;3947.4473573699706;3616.4575313703153;3713.424419215026;4025.9668867221867;4044.3418198538457;4047.8583249586122;4236.957630423656;4337.327714204303;4646.7444290564345;4665.297166534258;4764.999350136441;5013.874653133701;5141.38303403594;5306.814261500829;5441.292631957899;5659.377468478464;1148.74153315505;1239.7210627608715;1281.9487220511262;1288.6649471137384;1302.6092172348258;799.2806474173175;816.2286639126088;865.5931712095431;875.8073223890734;877.2192748453881;4124.608162224584;4833.993892534629;4834.903301934012;5118.923216151761;5290.418054014055;5347.786088556492;5899.941000590025;5905.928916963155;5922.674252916045;5977.491913187341;4978.651494395358;5231.869203269873;5308.946910530845;5342.732863356817;5360.16917377807;2750.601162831418;2891.667458242287;2891.9277018074717;2897.247614765981;2917.3144311086876;5116.334876466036;5290.867728306823;5697.296757107913;5721.256236689287;5774.422557744276;4643.56376281556;5110.003549307849;5565.30433695788;5626.352969408488;5755.85610359736;5209.984053109607;5587.608867379245;5751.971240143773;5826.446487583673;5831.795887144014;4980.626453015966;5156.303898973741;5259.60552958522;5374.408815030265;5580.274564306615;4387.3857659927;5161.870953226199;5476.042936814235;5531.566110911186;5534.7621641340265;4895.363602731622;5764.625299355528;5817.592768506164;5819.94180058194;5839.474447299764;3484.7038001770134;3717.683996860297;3725.5715592707184;3737.2712321097124;3743.3074881147077;4533.750643714628;5516.834494965157;5535.529479994085;5561;5578.163275508706;4542.659300552538;4887.14288570341;4978.054169707889;5234.612827600765;5439.504136362374;4466.620337271368;4601.378813860086;4828.34441057424;5330.653507521999;5430.782768689366;4818.638602104927;5593.860153496195;5603.467670571289;5642.23829782974;5642.605017648725;4290.206311832321;4548.747645433531;4634.745089020136;5542.279503664659;5614.326280846324;5567.66594004361;5596.580256480862;5597.972010139923;5622.85942851432;5632.197696737005 10:05:38 INFO - PROCESS | 1638 | |5;yui.html;658.9901151482726;711.477064357697;745.6644509970512;774.0749803984239;795.7374066558035;14765.335559899804;15424.460143894967;15682;15740.21298935053;15745.527634170965;14163.00858939872;14355.99508034438;14363.856361436383;14368.497102601412;14381.1371317721;691.9827004324882;713.2653367031966;716.0619588339292;852.7058164933104;867.7396780965717;595.2797115490262;712.0138608027867;712.9037579926695;845;874.4490970688457;916.715818096389;921.3458444504377;928.2295694573521;929.6885543342954;930.8696782450462;921.2215677752289;922.8846394200725;923.381334505876;923.5059243304834;923.8013827027221;687.1033301541486;688.9379955803952;689.2142957028991;690.0408432279136;690.1373283395756;14323.35544900482;14605.707885842223;14643.41426342945;14652.267386630625;14798;14176;14460.276986150755;14511.70976580473;14532.524368410563;14689.192094434802;11100.333979961148;11484.196106272564;11543.365114918675;11710.590129345432;11759.529618815322;4139.151473947863;4498.302763071729;4573.359729637853;4671.8364857229835;4791.592714619262;93127;94299.05700942971;96140.51929740307;97984;102504.46243306281;10567.788644227072;10841.566337346418;10884.748253950738;10886;11011.394373309546;20039.899800500905;20108.698369524467;20264.59470810605;20316.28892988738;20358.898205509173;7086.4685148613025;7255.709771609182;7326.194118646945;7335.376492998155;7376.3730082942475;4267.637250833714;4323.135372925428;4335.501417336984;4499.887502812456;4517.570830771071;3318.1870441741444;3401.183715908214;3429.1255729788745;3430.5540279763472;3433.1073920780777;550.6228233659956;622.6015350175891;636.9649669268142;645.3481983197005;647.9935200647933;570.823044856096;573.5096492498936;604.3442864491988;623.8378021714387;636.1348565950304;8635.654573816977;8889.4666320021;8937.73186804397;9058.547072646474;9109.681161159328;554.0857584984807;559.6479952538654;625.1778910732372;625.6715224507079;648.2447948140364;4060.9796951015055;4234.7670878102;4255.744655320691;4297.763623000765;4364.323529852878;120541.39729301297;121738;122117;122368;122927.38536307261;64237.35762642407;65946;66686.333136668;86528;88398;63768;78443.60778196073;78729.60635196902;82561.58719206366;86322.13677863266;9855.162311203629;9970.601175952881;9974.340285751301;10099.293049486465;10104.444255566015;55329;55483;56414;56718;57803.84392312046;73502;74946.62526687332;75625.62187189028;79083.60458197672;80850.59574702324;12546.12177147591;12813.679658008625;12932.094753367173;13019.804702929652;13112.344382781013;13667.38496767628;13667.453301867814;13715.588532343647;14136.50522231717;15395.76906346428;12926.935365323114;13866.376013079638;13911.51309704196;13942.093763905314;14064.718705626035;12772.872271277169;13221.338933053117;13705;13716.931415342859;13811.792823107862;10648.733781655521;10979.231453798158;12007.339596322287;12990.870091299344;13450.798238026633;10539.736506587396;10845.674629761119;11145.777084458103;11559.711007224887;11613.477393517143;8041.874137620621;9528.380655257386;9716.319857610182;10285.207035671967;10289.485525723834 10:05:38 INFO - PROCESS | 1638 | __end_tp_report 10:05:38 INFO - PROCESS | 1638 | __start_cc_report 10:05:38 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1520 10:05:38 INFO - PROCESS | 1638 | __end_cc_report 10:05:38 INFO - PROCESS | 1638 | __startTimestamp1486145138457__endTimestamp 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:05:38 INFO - PROCESS | 1638 | Number of tests: 6 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5787.17 Median:6056.91 stddev:640.55 (10.6%) stddev-sans-first:615.71 10:05:38 INFO - PROCESS | 1638 | Values: 3449.6 3480.9 3482.8 3514.4 3549.9 5640.2 5694.1 5725.2 5740.4 5755.6 5707.1 5815.4 5831.2 5839.6 5850.4 5214.1 5259.3 5260.4 5300.3 5337.7 5245.3 5248.4 5253.3 5261.2 5286.1 4358.8 5312.2 5319.6 5336.4 5385.4 5330.2 5334.4 5342.4 5343.8 5398.4 5093.9 5190.4 5259.9 5276.2 5280.6 5717.3 5725.1 5751.3 5781.4 5785.0 6182.7 6186.9 6219.9 6275.2 6279.7 5242.4 6252.3 6292.1 6299.1 6323.3 5946.6 5974.3 5997.4 5998.5 6009.9 6227.5 6238.7 6337.3 6339.9 6344.2 5493.3 6127.4 6146.7 6275.3 6285.8 6279.2 6299.5 6304.2 6322.9 6344.2 6127.7 6162.5 6162.5 6274.3 6289.2 6221.9 6258.3 6273.2 6279.3 6289.5 4963.5 5033.2 5039.5 5044.2 5058.4 4459.2 4469.0 4506.3 4539.2 4547.5 5692.9 5768.1 5786.7 5798.7 5823.7 5553.4 6259.9 6262.2 6263.6 6285.2 5860.9 5875.2 5877.0 5878.6 5893.3 5422.8 5445.1 5449.4 5509.1 5514.6 6396.4 6402.1 6420.6 6433.1 6448.4 6268.0 6278.2 6284.6 6297.6 6313.6 4804.7 6225.1 6319.7 6340.2 6385.0 6202.5 6230.4 6253.2 6272.1 6278.4 6238.7 6257.1 6273.1 6282.7 6286.4 6104.8 6139.9 6180.6 6213.1 6235.4 6120.0 6143.3 6187.3 6266.2 6277.4 6133.4 6139.9 6161.0 6167.7 6196.9 6056.9 6222.5 6228.5 6241.3 6274.7 4773.5 5918.5 5956.1 6073.4 6147.0 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:70800.75 Median:35909.14 stddev:161942.57 (451.0%) stddev-sans-first:162310.80 10:05:38 INFO - PROCESS | 1638 | Values: 482.3 504.5 531.5 531.5 537.4 30877.8 32802.5 40436.0 41139.4 41308.6 42899.6 43291.7 43305.0 43432.8 43467.1 9574.2 9723.1 9750.9 9751.2 9757.6 8975.2 9130.0 9130.1 9286.3 9590.3 9098.5 11643.6 11860.6 11884.7 12098.0 9743.7 11687.4 11706.6 11776.5 11783.3 11677.6 11761.8 11777.3 11778.6 11779.8 40124.0 40417.6 40423.8 40427.8 40463.8 3389.5 3402.0 3549.8 3662.8 3773.4 22767.0 29396.4 29457.8 30367.8 30875.1 3208.9 3314.6 3329.0 3435.4 3444.1 494391.0 497856.0 498608.5 499465.0 500392.0 27847.9 33863.5 59368.0 59815.7 59873.0 35799.8 35825.6 35884.6 35933.6 36026.0 14950.5 15110.8 15128.9 15135.1 15147.0 12775.6 12866.9 12875.4 12884.0 12929.0 7499.7 7624.2 7917.7 7918.2 8006.8 3280.6 3355.4 3367.3 3379.7 3381.2 983.8 1029.1 1070.0 1091.9 1095.6 23548.8 29445.0 29595.7 29915.6 29969.4 995.5 1063.3 1087.2 1138.4 1254.1 15149.2 15440.8 15446.2 15476.4 15866.5 663893.0 670726.0 671015.0 671428.0 672362.0 50135.7 50996.7 51832.0 51955.0 57624.0 1324.8 1376.0 1416.2 1420.0 1420.2 30006.2 30636.0 30778.5 30824.0 31255.1 49170.3 49628.5 49695.0 49742.8 49755.5 563172.0 567436.0 622176.0 639118.0 738420.0 25577.5 25649.6 25894.5 26146.2 26185.7 44534.8 44596.4 44711.3 44894.1 44977.6 36531.0 37090.0 37405.0 37500.4 37562.6 36686.3 36841.7 36971.8 37593.1 37876.6 36605.7 36664.8 37196.1 37282.4 37571.0 31876.5 33736.8 33819.2 33980.0 34113.3 24803.6 25171.6 25279.9 25662.0 25754.7 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35390.75 Median:2389.34 stddev:101617.19 (4252.9%) stddev-sans-first:101868.25 10:05:38 INFO - PROCESS | 1638 | Values: 378.6 382.7 390.7 394.6 414.7 14385.8 17706.8 20544.0 21656.9 21705.9 20878.7 20954.4 21101.7 21137.5 21273.0 5677.1 6109.9 6159.7 6166.8 6176.1 5876.4 6053.3 6090.3 6116.8 6164.2 5803.2 6052.4 6060.4 6063.2 6066.6 5790.2 6003.6 6049.7 6056.8 6086.0 5319.8 5325.5 5325.8 5327.8 5337.7 25120.4 26178.6 26230.5 26393.5 26537.3 1972.8 2199.8 2357.7 2421.0 2478.9 15590.6 16137.3 16244.9 16274.8 16569.8 1890.5 1927.2 1943.9 1944.5 2018.7 115847.4 117131.1 120432.4 121312.0 121448.0 9682.0 10516.9 10897.2 11453.7 11642.6 12685.6 13404.9 14340.2 14367.0 14372.8 7240.3 7634.9 8230.8 8746.4 8852.1 8896.9 8930.3 8944.0 9072.0 9161.2 5940.0 6259.9 6810.2 6970.6 6973.2 1791.3 1810.1 1872.0 1892.0 1907.5 887.7 971.7 993.7 1033.4 1045.0 21353.7 21579.9 21905.2 22025.0 22196.6 982.4 982.8 1009.6 1015.9 1031.9 8271.3 11242.0 11683.2 11754.5 11772.2 600338.0 605539.0 606465.0 621667.0 622522.0 108699.0 109818.0 116190.4 117326.4 120038.4 861.5 997.3 1045.2 1054.9 1064.0 15138.5 18560.6 18829.5 19247.2 19839.8 55578.7 57860.4 58413.0 58478.0 59037.1 58399.1 81319.2 81902.0 82812.8 84328.5 8013.4 8228.6 8394.6 8529.7 8589.0 9321.8 12701.1 12766.9 12783.8 13129.9 10869.3 11204.3 11271.8 11397.4 11402.4 10874.3 10936.6 11000.2 11371.9 11382.9 11177.3 11216.8 11688.4 11718.8 11756.8 6286.9 7326.0 7587.9 8133.0 8419.0 9789.4 9869.1 10872.0 11197.7 11549.3 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5508.24 Median:5125.58 stddev:3028.16 (59.1%) stddev-sans-first:3020.11 10:05:38 INFO - PROCESS | 1638 | Values: 1297.5 1376.1 1543.2 1700.9 1926.0 7659.2 8064.2 8324.9 8552.8 8561.7 8439.6 8500.5 8506.4 8545.9 8553.2 2011.4 2354.5 2410.1 2411.0 2413.8 2377.7 2434.1 2435.6 2436.6 2439.7 2373.9 2383.2 2401.8 2405.5 2410.8 2348.9 2366.1 2388.8 2392.1 2395.3 2350.6 2373.4 2414.9 2418.6 2418.9 8496.5 8534.3 8583.9 8600.9 8611.3 5198.1 5375.2 5376.7 5388.8 5392.8 3484.4 3618.6 3677.7 3681.7 3698.0 1098.3 1107.5 1121.0 1143.1 1144.3 11018.7 11025.9 11104.7 11107.0 11160.3 4355.9 4501.2 4602.9 4604.0 4615.7 8743.8 8749.9 8754.7 8759.4 8769.0 4322.2 5242.4 5244.7 5253.0 5258.0 4358.2 4472.3 4488.0 4606.5 4958.9 3783.5 3803.0 3851.6 3862.0 3865.7 1156.8 1159.3 1163.5 1175.6 1176.7 780.4 848.5 882.3 936.7 937.9 4979.5 5679.8 5789.0 5875.9 5945.5 781.6 889.8 934.1 935.6 945.7 3685.4 3725.9 3787.0 3880.7 3915.9 9642.6 10301.9 10388.1 10393.8 10403.7 10234.4 10335.5 10342.4 10348.6 10408.7 6582.3 8109.2 8177.8 8188.5 8192.6 5655.4 5665.8 5717.5 5882.8 5896.3 9566.1 9684.9 9694.3 9709.4 9726.9 9022.6 9326.3 9567.3 9803.4 9823.5 6736.8 6833.9 6910.8 6918.6 6995.9 8160.9 8174.5 8237.4 8243.4 8271.5 7214.9 7304.2 7347.2 7397.0 7450.9 7180.4 7206.2 7243.3 7249.2 7281.3 6646.4 6739.6 6832.7 6900.4 6910.9 4295.3 4356.7 4734.5 4753.0 4793.7 4512.1 4547.2 4625.6 4965.6 5053.1 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4493.05 Median:5113.17 stddev:1378.11 (27.0%) stddev-sans-first:1345.06 10:05:38 INFO - PROCESS | 1638 | Values: 271.9 285.9 312.5 320.3 322.6 5352.9 5381.9 5396.7 5421.7 5421.8 5328.4 5328.6 5332.5 5403.5 5406.5 3933.2 3947.3 3953.8 4069.8 4173.4 3705.3 4091.4 4154.1 4179.5 4196.6 3808.2 4051.3 4076.8 4098.3 4117.9 3539.6 3888.7 4008.8 4140.9 4156.8 3061.0 3422.4 3493.9 3496.4 3535.4 5250.7 5267.5 5272.6 5280.4 5333.5 4506.7 4631.6 4685.1 4689.5 4706.2 5156.1 5565.9 5665.2 5674.3 5702.8 3486.4 3921.6 3933.3 3934.5 3944.9 5719.7 5996.2 6041.9 6054.5 6077.8 3052.1 3895.5 3929.3 3940.8 3947.4 3616.5 3713.4 4026.0 4044.3 4047.9 4237.0 4337.3 4646.7 4665.3 4765.0 5013.9 5141.4 5306.8 5441.3 5659.4 1148.7 1239.7 1281.9 1288.7 1302.6 799.3 816.2 865.6 875.8 877.2 4124.6 4834.0 4834.9 5118.9 5290.4 5347.8 5899.9 5905.9 5922.7 5977.5 4978.7 5231.9 5308.9 5342.7 5360.2 2750.6 2891.7 2891.9 2897.2 2917.3 5116.3 5290.9 5697.3 5721.3 5774.4 4643.6 5110.0 5565.3 5626.4 5755.9 5210.0 5587.6 5752.0 5826.4 5831.8 4980.6 5156.3 5259.6 5374.4 5580.3 4387.4 5161.9 5476.0 5531.6 5534.8 4895.4 5764.6 5817.6 5819.9 5839.5 3484.7 3717.7 3725.6 3737.3 3743.3 4533.8 5516.8 5535.5 5561.0 5578.2 4542.7 4887.1 4978.1 5234.6 5439.5 4466.6 4601.4 4828.3 5330.7 5430.8 4818.6 5593.9 5603.5 5642.2 5642.6 4290.2 4548.7 4634.7 5542.3 5614.3 5567.7 5596.6 5598.0 5622.9 5632.2 10:05:38 INFO - PROCESS | 1638 | 10:05:38 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20610.62 Median:4508.73 stddev:30248.39 (670.9%) stddev-sans-first:30296.14 10:05:38 INFO - PROCESS | 1638 | Values: 659.0 711.5 745.7 774.1 795.7 14765.3 15424.5 15682.0 15740.2 15745.5 14163.0 14356.0 14363.9 14368.5 14381.1 692.0 713.3 716.1 852.7 867.7 595.3 712.0 712.9 845.0 874.4 916.7 921.3 928.2 929.7 930.9 921.2 922.9 923.4 923.5 923.8 687.1 688.9 689.2 690.0 690.1 14323.4 14605.7 14643.4 14652.3 14798.0 14176.0 14460.3 14511.7 14532.5 14689.2 11100.3 11484.2 11543.4 11710.6 11759.5 4139.2 4498.3 4573.4 4671.8 4791.6 93127.0 94299.1 96140.5 97984.0 102504.5 10567.8 10841.6 10884.7 10886.0 11011.4 20039.9 20108.7 20264.6 20316.3 20358.9 7086.5 7255.7 7326.2 7335.4 7376.4 4267.6 4323.1 4335.5 4499.9 4517.6 3318.2 3401.2 3429.1 3430.6 3433.1 550.6 622.6 637.0 645.3 648.0 570.8 573.5 604.3 623.8 636.1 8635.7 8889.5 8937.7 9058.5 9109.7 554.1 559.6 625.2 625.7 648.2 4061.0 4234.8 4255.7 4297.8 4364.3 120541.4 121738.0 122117.0 122368.0 122927.4 64237.4 65946.0 66686.3 86528.0 88398.0 63768.0 78443.6 78729.6 82561.6 86322.1 9855.2 9970.6 9974.3 10099.3 10104.4 55329.0 55483.0 56414.0 56718.0 57803.8 73502.0 74946.6 75625.6 79083.6 80850.6 12546.1 12813.7 12932.1 13019.8 13112.3 13667.4 13667.5 13715.6 14136.5 15395.8 12926.9 13866.4 13911.5 13942.1 14064.7 12772.9 13221.3 13705.0 13716.9 13811.8 10648.7 10979.2 12007.3 12990.9 13450.8 10539.7 10845.7 11145.8 11559.7 11613.5 8041.9 9528.4 9716.3 10285.2 10289.5 10:05:38 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:05:38 INFO - PROCESS | 1638 | 10:05:39 INFO - TEST-INFO | 1638: exit 0 10:05:39 INFO - TEST-OK | dromaeo_css | took 1117927ms 10:05:39 INFO - TEST-START | kraken 10:05:39 INFO - operating with platform_type : mac_ 10:05:39 INFO - Initialising browser for kraken test... 10:05:39 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpx1z8cQ/profile http://localhost:49236/getInfo.html) 10:05:41 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:05:41 INFO - PROCESS | 1648 | colorDepth:24 10:05:41 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:05:41 INFO - PROCESS | 1648 | __metrics 10:05:41 INFO - PROCESS | 1648 | 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:05:41 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:42 INFO - TEST-INFO | 1648: exit 0 10:05:42 INFO - Browser initialized. 10:05:42 INFO - Running cycle 1/1 for kraken test... 10:05:42 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpx1z8cQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:54 INFO - PROCESS | 1650 | RSS: Main: 172339200 10:05:54 INFO - PROCESS | 1650 | 10:05:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:58 INFO - PROCESS | 1650 | RSS: Main: 222056448 10:05:58 INFO - PROCESS | 1650 | 10:06:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:06:01 INFO - PROCESS | 1650 | RSS: Main: 233058304 10:06:01 INFO - PROCESS | 1650 | 10:06:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:06:05 INFO - PROCESS | 1650 | RSS: Main: 330932224 10:06:05 INFO - PROCESS | 1650 | 10:06:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:06:07 INFO - PROCESS | 1650 | RSS: Main: 232800256 10:06:07 INFO - PROCESS | 1650 | 10:06:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:10 INFO - PROCESS | 1650 | RSS: Main: 234442752 10:06:10 INFO - PROCESS | 1650 | 10:06:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:13 INFO - PROCESS | 1650 | RSS: Main: 274079744 10:06:13 INFO - PROCESS | 1650 | 10:06:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:17 INFO - PROCESS | 1650 | RSS: Main: 275959808 10:06:17 INFO - PROCESS | 1650 | 10:06:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:06:20 INFO - PROCESS | 1650 | RSS: Main: 272019456 10:06:20 INFO - PROCESS | 1650 | 10:06:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:22 INFO - PROCESS | 1650 | RSS: Main: 248774656 10:06:22 INFO - PROCESS | 1650 | 10:06:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:25 INFO - PROCESS | 1650 | RSS: Main: 253054976 10:06:25 INFO - PROCESS | 1650 | 10:06:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:27 INFO - PROCESS | 1650 | RSS: Main: 255602688 10:06:27 INFO - PROCESS | 1650 | 10:06:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:31 INFO - PROCESS | 1650 | RSS: Main: 267616256 10:06:31 INFO - PROCESS | 1650 | 10:06:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:34 INFO - PROCESS | 1650 | RSS: Main: 267894784 10:06:34 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:06:36 INFO - PROCESS | 1650 | RSS: Main: 311865344 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | __start_tp_report 10:06:36 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:06:36 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:06:36 INFO - PROCESS | 1650 | |i|pagename|runs| 10:06:36 INFO - PROCESS | 1650 | |0;ai-astar;114;114;114;114;114;114;112;113;114;114 10:06:36 INFO - PROCESS | 1650 | |1;audio-beat-detection;144;108;109;140;115;141;120;107;137;108 10:06:36 INFO - PROCESS | 1650 | |2;audio-dft;180;181;208;257;204;181;183;184;182;179 10:06:36 INFO - PROCESS | 1650 | |3;audio-fft;82;58;58;88;60;58;60;58;83;58 10:06:36 INFO - PROCESS | 1650 | |4;audio-oscillator;85;66;93;70;67;69;87;67;68;91 10:06:36 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;90;88;91;88;91;88;90;87;90;85 10:06:36 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;93;93;94;97;94;92;148;149;94 10:06:36 INFO - PROCESS | 1650 | |7;imaging-desaturate;80;83;78;81;81;81;83;82;80;80 10:06:36 INFO - PROCESS | 1650 | |8;json-parse-financial;53;53;52;54;56;57;57;57;56;56 10:06:36 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;62;70;68;73;73;68;68;68;71;68 10:06:36 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;82;79;82;82;81;81;83;85;80 10:06:36 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;138;135;136;133;134;139;144;150;196;144 10:06:36 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;162;162;166;164;162;161;164;161;162;162 10:06:36 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;64;65;64;65;66;64;64;63;66 10:06:36 INFO - PROCESS | 1650 | __end_tp_report 10:06:36 INFO - PROCESS | 1650 | __start_cc_report 10:06:36 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1939 10:06:36 INFO - PROCESS | 1650 | __end_cc_report 10:06:36 INFO - PROCESS | 1650 | __startTimestamp1486145196908__endTimestamp 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:06:36 INFO - PROCESS | 1650 | Number of tests: 14 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:06:36 INFO - PROCESS | 1650 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 112.0 113.0 114.0 114.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:128.50 stddev:15.72 (12.2%) stddev-sans-first:14.71 10:06:36 INFO - PROCESS | 1650 | Values: 144.0 108.0 109.0 140.0 115.0 141.0 120.0 107.0 137.0 108.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:193.90 Median:183.50 stddev:24.47 (13.3%) stddev-sans-first:25.43 10:06:36 INFO - PROCESS | 1650 | Values: 180.0 181.0 208.0 257.0 204.0 181.0 183.0 184.0 182.0 179.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.00 stddev:12.56 (20.9%) stddev-sans-first:11.97 10:06:36 INFO - PROCESS | 1650 | Values: 82.0 58.0 58.0 88.0 60.0 58.0 60.0 58.0 83.0 58.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:77.50 stddev:11.19 (14.4%) stddev-sans-first:11.41 10:06:36 INFO - PROCESS | 1650 | Values: 85.0 66.0 93.0 70.0 67.0 69.0 87.0 67.0 68.0 91.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.93 (2.1%) stddev-sans-first:2.00 10:06:36 INFO - PROCESS | 1650 | Values: 90.0 88.0 91.0 88.0 91.0 88.0 90.0 87.0 90.0 85.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:93.50 stddev:23.12 (24.7%) stddev-sans-first:24.14 10:06:36 INFO - PROCESS | 1650 | Values: 93.0 93.0 93.0 94.0 97.0 94.0 92.0 148.0 149.0 94.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:80.90 Median:81.00 stddev:1.52 (1.9%) stddev-sans-first:1.58 10:06:36 INFO - PROCESS | 1650 | Values: 80.0 83.0 78.0 81.0 81.0 81.0 83.0 82.0 80.0 80.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.91 (3.4%) stddev-sans-first:1.87 10:06:36 INFO - PROCESS | 1650 | Values: 53.0 53.0 52.0 54.0 56.0 57.0 57.0 57.0 56.0 56.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:3.18 (4.6%) stddev-sans-first:2.18 10:06:36 INFO - PROCESS | 1650 | Values: 62.0 70.0 68.0 73.0 73.0 68.0 68.0 68.0 71.0 68.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:1.69 (2.1%) stddev-sans-first:1.73 10:06:36 INFO - PROCESS | 1650 | Values: 83.0 82.0 79.0 82.0 82.0 81.0 81.0 83.0 85.0 80.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:141.50 stddev:18.73 (13.2%) stddev-sans-first:19.70 10:06:36 INFO - PROCESS | 1650 | Values: 138.0 135.0 136.0 133.0 134.0 139.0 144.0 150.0 196.0 144.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.60 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 10:06:36 INFO - PROCESS | 1650 | Values: 162.0 162.0 166.0 164.0 162.0 161.0 164.0 161.0 162.0 162.0 10:06:36 INFO - PROCESS | 1650 | 10:06:36 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 10:06:36 INFO - PROCESS | 1650 | Values: 65.0 64.0 65.0 64.0 65.0 66.0 64.0 64.0 63.0 66.0 10:06:36 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:06:36 INFO - PROCESS | 1650 | 10:06:37 INFO - TEST-INFO | 1650: exit 0 10:06:37 INFO - TEST-OK | kraken | took 58832ms 10:06:37 INFO - SUITE-END | took 1176s 10:06:38 INFO - Completed test suite (00:19:36) 10:06:38 INFO - javascript benchmark 10:06:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3449.6032956210033, 3480.860765569377, 3482.7736197147183, 3514.3674138655033, 3549.8580056797728, 5640.238567793347, 5694.060480020797, 5725.169850371693, 5740.397258287877, 5755.5971082024325, 5707.14392841074, 5815.447532484418, 5831.183634291203, 5839.591228613988, 5850.385709500505, 5214.139666954958, 5259.2899958505495, 5260.368755749297, 5300.284461597674, 5337.67973921564, 5245.31810864589, 5248.396434410034, 5253.290805741233, 5261.158214685651, 5286.10136276832, 4358.803853826569, 5312.150055991042, 5319.601029922752, 5336.359636843584, 5385.434529374418, 5330.200469929503, 5334.359876814788, 5342.385625653022, 5343.839684809482, 5398.433164517708, 5093.898122037538, 5190.377154741455, 5259.894802103975, 5276.2085687146855, 5280.577553795687, 5717.285339332583, 5725.141228815669, 5751.309842818847, 5781.364049954544, 5784.95870743266, 6182.721777520022, 6186.938130618726, 6219.937800621981, 6275.24697036354, 6279.7174127163935, 5242.449542797989, 6252.343503932113, 6292.119103325538, 6299.086632438317, 6323.272823625296, 5946.643201407886, 5974.2830860297045, 5997.370276120944, 5998.520118390518, 6009.879802403927, 6227.501799856001, 6238.656873871981, 6337.33457986914, 6339.936600633934, 6344.206974128234, 5493.340799104133, 6127.3566275540425, 6146.678464130234, 6275.341089185661, 6285.811425657238, 6279.152314437584, 6299.464545513591, 6304.18045654062, 6322.9051564226575, 6344.175257216532, 6127.6782420562195, 6162.506999440124, 6162.5378096642935, 6274.341194174637, 6289.213848268966, 6221.906671399933, 6258.3428739982555, 6273.215848018997, 6279.309275979638, 6289.496840252768, 4963.45402005779, 5033.245013247969, 5039.4708555601865, 5044.192929131322, 5058.367704036996, 4459.175052615276, 4469.0, 4506.324051392252, 4539.205639013159, 4547.522510136454, 5692.857678557986, 5768.134779783066, 5786.652800831964, 5798.710064496842, 5823.708814559255, 5553.444655534495, 6259.937400626027, 6262.248530176408, 6263.6241825490615, 6285.182926219562, 5860.882782344329, 5875.20684707559, 5877.000909845251, 5878.588498805128, 5893.3222679391565, 5422.783088676488, 5445.074337362578, 5449.4005659377435, 5509.146082357241, 5514.641548299348, 6396.360363963567, 6402.1357116790505, 6420.6147631142285, 6433.131527243762, 6448.355164483514, 6268.0, 6278.215223097113, 6284.5600807943, 6297.559170857996, 6313.621182729051, 4804.73573953422, 6225.128482012431, 6319.715612797343, 6340.175777149126, 6385.0, 6202.503799695924, 6230.408111229426, 6253.249610046823, 6272.121902933502, 6278.372162783685, 6238.6880655967925, 6257.0614407837365, 6273.121762953099, 6282.748690052346, 6286.402791734778, 6104.816855494165, 6139.8601398601395, 6180.567360284737, 6213.130161777264, 6235.438810507076, 6119.959572021022, 6143.296949342275, 6187.257529096537, 6266.185395898504, 6277.435030847246, 6133.44798968095, 6139.938600613937, 6160.9691951541745, 6167.660778657217, 6196.907046394217, 6056.9091463628965, 6222.502199824094, 6228.532860035425, 6241.3134555197985, 6274.749010039547, 4773.522647735199, 5918.496927761016, 5956.106584012433, 6073.362296958756, 6147.047207682816], "value": 5749.137666976683, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.2525086116519, 504.51818513319785, 531.4897698209719, 531.5322516185756, 537.3551737914504, 30877.845610771972, 32802.50796238055, 40435.99999999996, 41139.38290925631, 41308.58691413085, 42899.571004290025, 43291.701248962505, 43305.0, 43432.782836085775, 43467.130657386835, 9574.234061275116, 9723.12491875731, 9750.853737193947, 9751.17115045222, 9757.609695612167, 8975.192232699055, 9130.0, 9130.086991300883, 9286.257099432063, 9590.280728945358, 9098.454092754422, 11643.592474263403, 11860.64418067455, 11884.702882427922, 12098.0, 9743.658971935949, 11687.357195354252, 11706.648800535997, 11776.470058847286, 11783.293002419796, 11677.649670509898, 11761.764764704743, 11777.293362398283, 11778.587749428729, 11779.764404711857, 40123.996900077436, 40417.59582404197, 40423.7978810107, 40427.797861010506, 40463.78608641746, 3389.5254664347012, 3402.0304213299337, 3549.7692649977926, 3662.8351724172476, 3773.3585290500682, 22767.0, 29396.41207175866, 29457.821687132488, 30367.848160759055, 30875.073747787377, 3208.8876889308763, 3314.552535407737, 3328.9667103328898, 3435.381631306364, 3444.070101072721, 494391.0, 497856.0, 498608.5208721872, 499465.0, 500392.0, 27847.86076069607, 33863.49204761931, 59368.0, 59815.70092149598, 59873.0, 35799.82100089483, 35825.64174358223, 35884.64115358865, 35933.64066359355, 36026.0, 14950.476733314283, 15110.773338399933, 15128.924355378373, 15135.091894486146, 15147.0, 12775.61673149807, 12866.935665321613, 12875.420606072561, 12884.033697472727, 12929.0, 7499.737509187262, 7624.19945905683, 7917.722879699183, 7918.2477664621765, 8006.799830004296, 3280.6063272407464, 3355.3624811286268, 3367.326534693071, 3379.729621630264, 3381.2223188666744, 983.8081574092984, 1029.0789743179812, 1069.9679009629724, 1091.93994330311, 1095.5562996986234, 23548.764512355, 29445.0, 29595.704042959725, 29915.551266731018, 29969.40061198764, 995.5221493683073, 1063.3460421840512, 1087.244365166202, 1138.4364739453858, 1254.0657210378145, 15149.242537873062, 15440.764738820868, 15446.227688615525, 15476.380944762308, 15866.52400427989, 663893.0, 670726.0, 671015.0, 671428.0, 672362.0, 50135.74932125316, 50996.745016275425, 51832.0, 51955.0, 57623.98316058918, 1324.8145259663654, 1376.0, 1416.2140012293276, 1419.9989007749512, 1420.2401715082588, 30006.24984375321, 30636.0, 30778.538321925636, 30824.0, 31255.06234812959, 49170.26244606405, 49628.51114466572, 49695.0, 49742.751286243336, 49755.502444975085, 563172.0, 567436.0, 622176.0, 639118.0, 738420.0, 25577.488450231263, 25649.615255770805, 25894.482110357312, 26146.215613530865, 26185.73814261909, 44534.77732611316, 44596.43228541644, 44711.329330060726, 44894.102117958115, 44977.55022449734, 36531.0, 37090.0, 37405.0, 37500.43749343816, 37562.62437375591, 36686.26627467489, 36841.65863836682, 36971.815140924125, 37593.060173495884, 37876.62123378841, 36605.70548650634, 36664.81667591645, 37196.07009824776, 37282.440763388026, 37571.0, 31876.521852171772, 33736.83131584425, 33819.15452113618, 33979.98060058202, 34113.31773364469, 24803.62794558047, 25171.622425663263, 25279.87360063188, 25662.0, 25754.742452575236], "value": 18855.96239860752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6062495005194, 382.724438404349, 390.65011101386057, 394.587655899585, 414.66205042890044, 14385.784213236784, 17706.82293177068, 20544.0, 21656.89171554142, 21705.891470542643, 20878.686819697716, 20954.37136885892, 21101.733895966252, 21137.47156321093, 21273.0, 5677.120046392805, 6109.908351374733, 6159.722812473427, 6166.81499555014, 6176.135341052256, 5876.353601103875, 6053.334133245339, 6090.299615544225, 6116.7553297868035, 6164.167837341969, 5803.187553742479, 6052.425019623129, 6060.363661815512, 6063.151158837766, 6066.605670631417, 5790.218320526717, 6003.639781613074, 6049.66726830022, 6056.848578785522, 6086.02623580225, 5319.787208511655, 5325.467453254682, 5325.840224793224, 5327.786888524454, 5337.70642614656, 25120.371990700194, 26178.6073208902, 26230.475390492273, 26393.472130557282, 26537.336566585796, 1972.8421726261865, 2199.802017818388, 2357.6817129687443, 2421.0073869713333, 2478.876056197201, 15590.610234744108, 16137.273822678007, 16244.918775406166, 16274.75587866183, 16569.751453728204, 1890.5273681579606, 1927.1905799564217, 1943.9416817495498, 1944.4944314478196, 2018.7476565429322, 115847.4207628965, 117131.07172320675, 120432.39783801112, 121311.99999999911, 121448.0, 9682.0, 10516.948305169575, 10897.182711296684, 11453.71365715847, 11642.592509262135, 12685.619431417072, 13404.865951340362, 14340.21128837924, 14367.0, 14372.784408233885, 7240.348368646847, 7634.923650763421, 8230.753077407688, 8746.431481953652, 8852.070532594114, 8896.909226331807, 8930.285577153812, 8944.01615822259, 9072.0, 9161.17549420542, 5940.019896716994, 6259.873222819936, 6810.216825065082, 6970.616616086164, 6973.163220413583, 1791.2566284991842, 1810.1311370542214, 1871.990640046791, 1891.9810801892081, 1907.513584036062, 887.7425546591417, 971.6793458158791, 993.7416271769248, 1033.4161198922734, 1044.984325235122, 21353.707900753085, 21579.880622362205, 21905.207514111473, 22025.00887460068, 22196.556068878534, 982.4007355513131, 982.832918403873, 1009.5961615353771, 1015.9441230732233, 1031.9484025798681, 8271.296939760068, 11242.0, 11683.240589361665, 11754.471048802825, 11772.17594768375, 600337.9983100144, 605539.0, 606465.0, 621667.0, 622522.0, 108699.0, 109818.0, 116190.41904790422, 117326.41336793432, 120038.3998080004, 861.4874149880811, 997.3467378866853, 1045.231754660324, 1054.9156067514427, 1063.984040239397, 15138.470153545013, 18560.607954403742, 18829.529261768566, 19247.230110795972, 19839.801601983796, 55578.72210638921, 57860.4213957855, 58412.95554655567, 58478.0, 59037.114443282524, 58399.124013138986, 81319.18680813115, 81902.0, 82812.75780863171, 84328.51864628779, 8013.439059265796, 8228.588570571566, 8394.622241999246, 8529.701460448854, 8589.0, 9321.766955826159, 12701.110922235355, 12766.936165319114, 12783.80824287655, 13129.934350328569, 10869.29349592274, 11204.327740335606, 11271.774564508827, 11397.373144476802, 11402.372869492257, 10874.34753914736, 10936.562537498728, 11000.22998390137, 11371.886281137413, 11382.943085284853, 11177.329360238411, 11216.775664486828, 11688.357140357022, 11718.824217636571, 11756.823647645464, 6286.905696414649, 7325.974363588995, 7587.8997545356715, 8132.959335203286, 8419.0, 9789.363691360039, 9869.111779939552, 10872.021518063413, 11197.72005699864, 11549.307041577533], "value": 9831.503878296402, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.506947360003, 1376.0505251376555, 1543.2360981314248, 1700.9149542522878, 1925.9807401925978, 7659.1574926758085, 8064.193580641941, 8324.916750832483, 8552.828943421127, 8561.743147705578, 8439.57802109895, 8500.489970601768, 8506.447080939735, 8545.871811922827, 8553.230209281164, 2011.3764732932764, 2354.5290941811622, 2410.0721222329444, 2410.963835542468, 2413.8431001984904, 2377.738448770634, 2434.1358817619666, 2435.6468312094735, 2436.5502525997003, 2439.6828412306377, 2373.905043798246, 2383.249276477904, 2401.771831675988, 2405.458771776345, 2410.758924107593, 2348.8825558721996, 2366.0890557135453, 2388.7611238876148, 2392.114917480526, 2395.2574701842395, 2350.576896158691, 2373.4422410733464, 2414.9034038638433, 2418.600930846408, 2418.8790560471907, 8496.490210587384, 8534.274586660142, 8583.871241931314, 8600.8709869352, 8611.311095112376, 5198.064348417283, 5375.220593013991, 5376.704281264529, 5388.838334849961, 5392.78428862845, 3484.407650699387, 3618.6381361863864, 3677.687396571295, 3681.650243226889, 3698.0, 1098.3355070182583, 1107.479484642217, 1120.9943950280197, 1143.1369316166324, 1144.2962578014544, 11018.724531886686, 11025.944870275678, 11104.666859994213, 11107.0, 11160.274582152135, 4355.912881742347, 4501.189785838515, 4602.88492787683, 4604.033153037833, 4615.723056616614, 8743.825123497621, 8749.91250087491, 8754.737357879274, 8759.386842920934, 8769.0, 4322.243607368698, 5242.397124330674, 5244.659097158673, 5252.973735131376, 5258.0, 4358.21552120615, 4472.284434490466, 4488.0, 4606.539346065367, 4958.925616115761, 3783.45139954705, 3802.980985095057, 3851.595582463801, 3861.961380386216, 3865.6714179294513, 1156.7570810129967, 1159.2812456276993, 1163.5462169753803, 1175.623800383869, 1176.7293522489874, 780.449782903052, 848.4866655673352, 882.2853488674194, 936.6628013914985, 937.9484128372868, 4979.45226025137, 5679.801206957736, 5789.0, 5875.9118613220835, 5945.524358051345, 781.5506084001722, 889.822035592884, 934.1265916368218, 935.6304259817471, 945.7257395355407, 3685.355062863988, 3725.8695945642316, 3787.0, 3880.689544836406, 3915.941260881089, 9642.566084526214, 10301.9484902575, 10388.117010054078, 10393.792124157626, 10403.739906502247, 10234.437105959243, 10335.534900929326, 10342.37945723259, 10348.637797677045, 10408.687739367831, 6582.275949645536, 8109.189081091961, 8177.795555111051, 8188.549629770419, 8192.631331590093, 5655.406182350794, 5665.801696940587, 5717.485426311486, 5882.764689412375, 5896.292444906639, 9566.139047485482, 9684.85472717924, 9694.321397502106, 9709.417434953926, 9726.854097188689, 9022.593983270637, 9326.347155699035, 9567.330286879851, 9803.411795292306, 9823.508824558887, 6736.7642132525125, 6833.89749153773, 6910.7581234656545, 6918.5502942308585, 6995.860082798417, 8160.877586836321, 8174.509529428254, 8237.393708226838, 8243.381746369167, 8271.503709777433, 7214.927850721426, 7304.19653838088, 7347.155077166194, 7397.0, 7450.8509829802015, 7180.389666878374, 7206.207317195209, 7243.348098671145, 7249.166345870292, 7281.308275713799, 6646.368594983469, 6739.59562426256, 6832.658367081725, 6900.447964162755, 6910.8617827644175, 4295.269804133242, 4356.695031347902, 4734.526547345238, 4753.0256297458245, 4793.736344500946, 4512.120136573337, 4547.226971414933, 4625.583697467109, 4965.577925876197, 5053.090443720019], "value": 4460.19225938475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.8912435025989, 285.858500042479, 312.4812810734181, 320.29055641753513, 322.57903436016016, 5352.91970620441, 5381.865453363668, 5396.703181325035, 5421.728913554326, 5421.837344879655, 5328.413874473805, 5328.600354973383, 5332.493413125757, 5403.541388668156, 5406.513413792758, 3933.2330195611867, 3947.269755095302, 3953.8418463261505, 4069.8197522718374, 4173.394857745625, 3705.277046173542, 4091.3862920561855, 4154.086101057763, 4179.498460184782, 4196.643285320736, 3808.1622043150464, 4051.3112770828884, 4076.7961601919787, 4098.262312783698, 4117.899871065763, 3539.557555305587, 3888.7083468739957, 4008.83964641414, 4140.8964775880695, 4156.771377574248, 3061.0204734484973, 3422.435298175798, 3493.94759078614, 3496.4405695088662, 3535.3636345457808, 5250.65870718402, 5267.499587539178, 5272.57819374453, 5280.419153893069, 5333.493318134771, 4506.684532082755, 4631.633668067928, 4685.109829132454, 4689.507601701806, 4706.1999460091865, 5156.149235376159, 5565.9443405566235, 5665.2351932489, 5674.340050667338, 5702.800401985952, 3486.3724529584665, 3921.607839216084, 3933.272344616255, 3934.547527034399, 3944.9408258876138, 5719.739748343446, 5996.192417814632, 6041.909371359433, 6054.545909056838, 6077.7568897244055, 3052.069118918707, 3895.474110995036, 3929.2730844793805, 3940.7832569208394, 3947.4473573699706, 3616.4575313703153, 3713.424419215026, 4025.9668867221867, 4044.3418198538457, 4047.8583249586122, 4236.957630423656, 4337.327714204303, 4646.7444290564345, 4665.297166534258, 4764.999350136441, 5013.874653133701, 5141.38303403594, 5306.814261500829, 5441.292631957899, 5659.377468478464, 1148.74153315505, 1239.7210627608715, 1281.9487220511262, 1288.6649471137384, 1302.6092172348258, 799.2806474173175, 816.2286639126088, 865.5931712095431, 875.8073223890734, 877.2192748453881, 4124.608162224584, 4833.993892534629, 4834.903301934012, 5118.923216151761, 5290.418054014055, 5347.786088556492, 5899.941000590025, 5905.928916963155, 5922.674252916045, 5977.491913187341, 4978.651494395358, 5231.869203269873, 5308.946910530845, 5342.732863356817, 5360.16917377807, 2750.601162831418, 2891.667458242287, 2891.9277018074717, 2897.247614765981, 2917.3144311086876, 5116.334876466036, 5290.867728306823, 5697.296757107913, 5721.256236689287, 5774.422557744276, 4643.56376281556, 5110.003549307849, 5565.30433695788, 5626.352969408488, 5755.85610359736, 5209.984053109607, 5587.608867379245, 5751.971240143773, 5826.446487583673, 5831.795887144014, 4980.626453015966, 5156.303898973741, 5259.60552958522, 5374.408815030265, 5580.274564306615, 4387.3857659927, 5161.870953226199, 5476.042936814235, 5531.566110911186, 5534.7621641340265, 4895.363602731622, 5764.625299355528, 5817.592768506164, 5819.94180058194, 5839.474447299764, 3484.7038001770134, 3717.683996860297, 3725.5715592707184, 3737.2712321097124, 3743.3074881147077, 4533.750643714628, 5516.834494965157, 5535.529479994085, 5561.0, 5578.163275508706, 4542.659300552538, 4887.14288570341, 4978.054169707889, 5234.612827600765, 5439.504136362374, 4466.620337271368, 4601.378813860086, 4828.34441057424, 5330.653507521999, 5430.782768689366, 4818.638602104927, 5593.860153496195, 5603.467670571289, 5642.23829782974, 5642.605017648725, 4290.206311832321, 4548.747645433531, 4634.745089020136, 5542.279503664659, 5614.326280846324, 5567.66594004361, 5596.580256480862, 5597.972010139923, 5622.85942851432, 5632.197696737005], "value": 4047.6204885349234, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.9901151482726, 711.477064357697, 745.6644509970512, 774.0749803984239, 795.7374066558035, 14765.335559899804, 15424.460143894967, 15682.0, 15740.21298935053, 15745.527634170965, 14163.00858939872, 14355.99508034438, 14363.856361436383, 14368.497102601412, 14381.1371317721, 691.9827004324882, 713.2653367031966, 716.0619588339292, 852.7058164933104, 867.7396780965717, 595.2797115490262, 712.0138608027867, 712.9037579926695, 845.0, 874.4490970688457, 916.715818096389, 921.3458444504377, 928.2295694573521, 929.6885543342954, 930.8696782450462, 921.2215677752289, 922.8846394200725, 923.381334505876, 923.5059243304834, 923.8013827027221, 687.1033301541486, 688.9379955803952, 689.2142957028991, 690.0408432279136, 690.1373283395756, 14323.35544900482, 14605.707885842223, 14643.41426342945, 14652.267386630625, 14798.0, 14176.0, 14460.276986150755, 14511.70976580473, 14532.524368410563, 14689.192094434802, 11100.333979961148, 11484.196106272564, 11543.365114918675, 11710.590129345432, 11759.529618815322, 4139.151473947863, 4498.302763071729, 4573.359729637853, 4671.8364857229835, 4791.592714619262, 93127.0, 94299.05700942971, 96140.51929740307, 97984.0, 102504.46243306281, 10567.788644227072, 10841.566337346418, 10884.748253950738, 10886.0, 11011.394373309546, 20039.899800500905, 20108.698369524467, 20264.59470810605, 20316.28892988738, 20358.898205509173, 7086.4685148613025, 7255.709771609182, 7326.194118646945, 7335.376492998155, 7376.3730082942475, 4267.637250833714, 4323.135372925428, 4335.501417336984, 4499.887502812456, 4517.570830771071, 3318.1870441741444, 3401.183715908214, 3429.1255729788745, 3430.5540279763472, 3433.1073920780777, 550.6228233659956, 622.6015350175891, 636.9649669268142, 645.3481983197005, 647.9935200647933, 570.823044856096, 573.5096492498936, 604.3442864491988, 623.8378021714387, 636.1348565950304, 8635.654573816977, 8889.4666320021, 8937.73186804397, 9058.547072646474, 9109.681161159328, 554.0857584984807, 559.6479952538654, 625.1778910732372, 625.6715224507079, 648.2447948140364, 4060.9796951015055, 4234.7670878102, 4255.744655320691, 4297.763623000765, 4364.323529852878, 120541.39729301297, 121738.0, 122117.0, 122368.0, 122927.38536307261, 64237.35762642407, 65946.0, 66686.333136668, 86528.0, 88398.0, 63768.0, 78443.60778196073, 78729.60635196902, 82561.58719206366, 86322.13677863266, 9855.162311203629, 9970.601175952881, 9974.340285751301, 10099.293049486465, 10104.444255566015, 55329.0, 55483.0, 56414.0, 56718.0, 57803.84392312046, 73502.0, 74946.62526687332, 75625.62187189028, 79083.60458197672, 80850.59574702324, 12546.12177147591, 12813.679658008625, 12932.094753367173, 13019.804702929652, 13112.344382781013, 13667.38496767628, 13667.453301867814, 13715.588532343647, 14136.50522231717, 15395.76906346428, 12926.935365323114, 13866.376013079638, 13911.51309704196, 13942.093763905314, 14064.718705626035, 12772.872271277169, 13221.338933053117, 13705.0, 13716.931415342859, 13811.792823107862, 10648.733781655521, 10979.231453798158, 12007.339596322287, 12990.870091299344, 13450.798238026633, 10539.736506587396, 10845.674629761119, 11145.777084458103, 11559.711007224887, 11613.477393517143, 8041.874137620621, 9528.380655257386, 9716.319857610182, 10285.207035671967, 10289.485525723834], "value": 7357.807962761685, "unit": "score"}], "name": "dromaeo_css", "value": 7219.433353449496, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 112.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 109.0, 140.0, 115.0, 141.0, 120.0, 107.0, 137.0, 108.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 208.0, 257.0, 204.0, 181.0, 183.0, 184.0, 182.0, 179.0], "value": 193.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 88.0, 60.0, 58.0, 60.0, 58.0, 83.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 66.0, 93.0, 70.0, 67.0, 69.0, 87.0, 67.0, 68.0, 91.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 88.0, 91.0, 88.0, 90.0, 87.0, 90.0, 85.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 97.0, 94.0, 92.0, 148.0, 149.0, 94.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 78.0, 81.0, 81.0, 81.0, 83.0, 82.0, 80.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 56.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 68.0, 73.0, 73.0, 68.0, 68.0, 68.0, 71.0, 68.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 79.0, 82.0, 82.0, 81.0, 81.0, 83.0, 85.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 136.0, 133.0, 134.0, 139.0, 144.0, 150.0, 196.0, 144.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 164.0, 162.0, 161.0, 164.0, 161.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0, 63.0, 66.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1425.3999999999999, "alertThreshold": 2.0}]} 10:06:38 INFO - Return code: 0 10:06:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:06:38 INFO - # TBPL SUCCESS # 10:06:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:38 INFO - 2017-02-03 10:06:38.270 screenresolution[1654:9778] starting screenresolution argv=screenresolution get 10:06:38 INFO - 2017-02-03 10:06:38.273 screenresolution[1654:9778] Display 0: 1600x1200x32@60 10:06:38 INFO - 2017-02-03 10:06:38.279 screenresolution[1655:9781] starting screenresolution argv=screenresolution list 10:06:38 INFO - Available Modes on Display 0 10:06:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:38 INFO - Intel Iris: 10:06:38 INFO - Chipset Model: Intel Iris 10:06:38 INFO - Type: GPU 10:06:38 INFO - Bus: Built-In 10:06:38 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:38 INFO - Vendor: Intel (0x8086) 10:06:38 INFO - Device ID: 0x0a2e 10:06:38 INFO - Revision ID: 0x0009 10:06:38 INFO - Displays: 10:06:38 INFO - Display: 10:06:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:38 INFO - Display Serial Number: 1600x1200 60 10:06:38 INFO - Main Display: Yes 10:06:38 INFO - Mirror: Off 10:06:38 INFO - Online: Yes 10:06:38 INFO - Rotation: Supported 10:06:38 INFO - Return code: 0 10:06:38 INFO - Running post-action listener: _resource_record_post_action 10:06:38 INFO - [mozharness: 2017-02-03 18:06:38.520551Z] Finished run-tests step (success) 10:06:38 INFO - Running post-run listener: _resource_record_post_run 10:06:38 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 37553152; Write bytes: 501996032; Read time: 241; Write time: 1619 10:06:38 INFO - TinderboxPrint: CPU usage
53.2% 10:06:38 INFO - TinderboxPrint: I/O read bytes / time
37,553,152 / 241 10:06:38 INFO - TinderboxPrint: I/O write bytes / time
501,996,032 / 1,619 10:06:38 INFO - TinderboxPrint: CPU idle
2,245.1 (46.8%) 10:06:38 INFO - TinderboxPrint: CPU system
955.0 (19.9%) 10:06:38 INFO - TinderboxPrint: CPU user
1,597.6 (33.3%) 10:06:38 INFO - TinderboxPrint: Swap in / out
228,921,344 / 0 10:06:38 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192483840; Write bytes: 193873408; Read time: 17504; Write time: 443 10:06:38 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34481152; Write bytes: 306754560; Read time: 217; Write time: 1172 10:06:38 INFO - Running post-run listener: _upload_blobber_files 10:06:38 INFO - Blob upload gear active. 10:06:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:38 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:06:38 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:06:38 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:06:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:40 INFO - (blobuploader) - INFO - Done attempting. 10:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:41 INFO - (blobuploader) - INFO - Done attempting. 10:06:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:06:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:06:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:43 INFO - (blobuploader) - INFO - Done attempting. 10:06:43 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:43 INFO - Return code: 0 10:06:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63f7eda10e94b36b1dd072a142c217ce1eaea007b918510a692add33840eccc7300e389c6e576ebc09357ffc8d9173a7123549f13eeeeba263fa52d9d55ec676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7aee457b6158693d7e3e12088adbcb0a8f71e03b53d53387fe8430a53eba2bbf091b6c1a63ae8e921d5378332f3388c4ab4c16d4c5e2e1cbdb9d74dd2249be1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1b583868299d3b74014b1552603db9f696fd292f2f8a6b995a74c60b3f7dd05827b62794cbedb02338a074077ce3533753fa2903a740833668de7308b6d498e"} 10:06:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:43 INFO - Contents: 10:06:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63f7eda10e94b36b1dd072a142c217ce1eaea007b918510a692add33840eccc7300e389c6e576ebc09357ffc8d9173a7123549f13eeeeba263fa52d9d55ec676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7aee457b6158693d7e3e12088adbcb0a8f71e03b53d53387fe8430a53eba2bbf091b6c1a63ae8e921d5378332f3388c4ab4c16d4c5e2e1cbdb9d74dd2249be1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1b583868299d3b74014b1552603db9f696fd292f2f8a6b995a74c60b3f7dd05827b62794cbedb02338a074077ce3533753fa2903a740833668de7308b6d498e"} 10:06:43 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:43 INFO - Copying logs to upload dir... 10:06:43 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.617379 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-03 10:06:43.791411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 10:06:43.795597) ========= 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.elxjlcUixr/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.46AQcX2Sry/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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/63f7eda10e94b36b1dd072a142c217ce1eaea007b918510a692add33840eccc7300e389c6e576ebc09357ffc8d9173a7123549f13eeeeba263fa52d9d55ec676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7aee457b6158693d7e3e12088adbcb0a8f71e03b53d53387fe8430a53eba2bbf091b6c1a63ae8e921d5378332f3388c4ab4c16d4c5e2e1cbdb9d74dd2249be1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1b583868299d3b74014b1552603db9f696fd292f2f8a6b995a74c60b3f7dd05827b62794cbedb02338a074077ce3533753fa2903a740833668de7308b6d498e"} build_url:https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011547 build_url: 'https://queue.taskcluster.net/v1/task/DdrV1RECQpGtZM3E7MlQHg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/63f7eda10e94b36b1dd072a142c217ce1eaea007b918510a692add33840eccc7300e389c6e576ebc09357ffc8d9173a7123549f13eeeeba263fa52d9d55ec676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7aee457b6158693d7e3e12088adbcb0a8f71e03b53d53387fe8430a53eba2bbf091b6c1a63ae8e921d5378332f3388c4ab4c16d4c5e2e1cbdb9d74dd2249be1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1b583868299d3b74014b1552603db9f696fd292f2f8a6b995a74c60b3f7dd05827b62794cbedb02338a074077ce3533753fa2903a740833668de7308b6d498e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 10:06:43.830053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:06:43.833383) ========= 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.elxjlcUixr/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.46AQcX2Sry/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005316 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:06:43.885626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 10:06:43.885953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 10:06:43.886281) ========= ========= Total master_lag: 10.53 =========