builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0322 starttime: 1477515052.57 results: success (0) buildid: 20161026075526 builduid: 1b6e62fa11104b93a83fb80681645e95 revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.565861) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.566216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.566480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.641299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.641545) ========= 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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 --2016-10-26 13:50:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-10-26 13:50:53 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.525189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.189543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.189830) ========= 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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.024799 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.239610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:50:53.239966) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 2016-10-26 13:50:53,321 truncating revision to first 12 chars 2016-10-26 13:50:53,322 Setting DEBUG logging. 2016-10-26 13:50:53,322 attempt 1/10 2016-10-26 13:50:53,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:50:54,338 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.281895 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:50:54.553230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.553505) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.553892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.558296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.586380) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 13:50:54.586651) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:50:54 INFO - MultiFileLogger online at 20161026 13:50:54 in /builds/slave/test 13:50:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:54 INFO - {'append_to_log': False, 13:50:54 INFO - 'base_work_dir': '/builds/slave/test', 13:50:54 INFO - 'blob_upload_branch': 'Firefox', 13:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:54 INFO - 'branch': 'Firefox', 13:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:54 INFO - 'config_files': ('talos/mac_config.py',), 13:50:54 INFO - 'default_actions': ('clobber', 13:50:54 INFO - 'read-buildbot-config', 13:50:54 INFO - 'download-and-extract', 13:50:54 INFO - 'populate-webroot', 13:50:54 INFO - 'create-virtualenv', 13:50:54 INFO - 'install', 13:50:54 INFO - 'run-tests'), 13:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:54 INFO - 'download_minidump_stackwalk': True, 13:50:54 INFO - 'download_symbols': 'ondemand', 13:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:54 INFO - 'installer_path': 'installer.exe', 13:50:54 INFO - 'log_level': 'info', 13:50:54 INFO - 'log_name': 'talos', 13:50:54 INFO - 'log_to_console': True, 13:50:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:54 INFO - 'opt_config_files': (), 13:50:54 INFO - 'pip_index': False, 13:50:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'run_cmd_checks_enabled': True, 13:50:54 INFO - 'sps_profile': False, 13:50:54 INFO - 'sps_profile_interval': 0, 13:50:54 INFO - 'suite': 'dromaeojs', 13:50:54 INFO - 'system_bits': '32', 13:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:54 INFO - 'title': 't-yosemite-r7-0322', 13:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:54 INFO - 'use_talos_json': True, 13:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:54 INFO - 'work_dir': 'build'} 13:50:54 INFO - [mozharness: 2016-10-26 20:50:54.799426Z] Running clobber step. 13:50:54 INFO - Running pre-action listener: _resource_record_pre_action 13:50:54 INFO - Running main action method: clobber 13:50:54 INFO - rmtree: /builds/slave/test/build 13:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.944911Z] Finished clobber step (success) 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.945037Z] Running read-buildbot-config step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: read_buildbot_config 13:50:56 INFO - Using buildbot properties: 13:50:56 INFO - { 13:50:56 INFO - "project": "", 13:50:56 INFO - "product": "firefox", 13:50:56 INFO - "script_repo_revision": "production", 13:50:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:50:56 INFO - "repository": "", 13:50:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:50:56 INFO - "buildid": "20161026075526", 13:50:56 INFO - "pgo_build": "False", 13:50:56 INFO - "basedir": "/builds/slave/test", 13:50:56 INFO - "buildnumber": 11, 13:50:56 INFO - "slavename": "t-yosemite-r7-0322", 13:50:56 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 13:50:56 INFO - "platform": "yosemite_r7", 13:50:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:56 INFO - "branch": "mozilla-central", 13:50:56 INFO - "repo_path": "mozilla-central", 13:50:56 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:50:56 INFO - "stage_platform": "macosx64", 13:50:56 INFO - "builduid": "1b6e62fa11104b93a83fb80681645e95", 13:50:56 INFO - "slavebuilddir": "test" 13:50:56 INFO - } 13:50:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:56 INFO - Running post-action listener: _resource_record_post_action 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.948382Z] Finished read-buildbot-config step (success) 13:50:56 INFO - [mozharness: 2016-10-26 20:50:56.948489Z] Running download-and-extract step. 13:50:56 INFO - Running pre-action listener: _resource_record_pre_action 13:50:56 INFO - Running main action method: download_and_extract 13:50:56 INFO - mkdir: /builds/slave/test/build/tests 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:56 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:50:58 INFO - Downloaded 1199 bytes. 13:50:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:58 INFO - Using the following test package requirements: 13:50:58 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'jsshell-mac.zip'], 13:50:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:58 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:58 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:58 INFO - Http code: 200 13:50:58 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 13:50:58 INFO - x-amz-cf-id: gI7PvtLNZa2LAcfikSR24LXBt7dE19RPNJmjSUmBsu3IuH33nEM2zQ== 13:50:58 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:50:58 INFO - Expected file size: 16442708 13:50:58 INFO - Obtained file size: 16442708 13:51:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:51:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:51:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:51:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:51:06 INFO - Http code: 200 13:51:06 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 13:51:06 INFO - x-amz-cf-id: bdoJQavEkzo2mUd_TeNDyiExmVOXWW61LkhlQw4KNOpOFbKVDlDLeA== 13:51:06 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:51:06 INFO - Expected file size: 16442708 13:51:06 INFO - Obtained file size: 16442708 13:51:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:51:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:51:13 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:51:13 INFO - Http code: 200 13:51:13 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 13:51:13 INFO - x-amz-cf-id: 5MArau03Jv2dyvoPehBVXKc84OEd0emzW9AR1smVyJH-otTHAipw2Q== 13:51:13 INFO - x-amz-version-id: 0bXUQ92dp_r4joro14ZW7j22G0F3vbr6 13:51:14 INFO - Expected file size: 14409028 13:51:14 INFO - Obtained file size: 14409028 13:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:14 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:51:17 INFO - Downloaded 111730824 bytes. 13:51:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:17 INFO - mkdir: /builds/slave/test/properties 13:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:17 INFO - Contents: 13:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:18 INFO - Running post-action listener: _resource_record_post_action 13:51:18 INFO - Running post-action listener: set_extra_try_arguments 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.337780Z] Finished download-and-extract step (success) 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.337870Z] Running populate-webroot step. 13:51:18 INFO - Running pre-action listener: _resource_record_pre_action 13:51:18 INFO - Running main action method: populate_webroot 13:51:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:18 INFO - '--tppagecycles', 13:51:18 INFO - '7'], 13:51:18 INFO - 'tests': ['tsvgm']}}, 13:51:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['damp', 'tps']}, 13:51:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['damp', 'tps']}, 13:51:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['dromaeo_dom']}, 13:51:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['basic_compositor_video']}, 13:51:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tsvgx', 13:51:18 INFO - 'tsvgr_opacity', 13:51:18 INFO - 'tart', 13:51:18 INFO - 'tscrollx', 13:51:18 INFO - 'cart']}, 13:51:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:18 INFO - 'tsvgr_opacity', 13:51:18 INFO - 'tart', 13:51:18 INFO - 'tscrollx', 13:51:18 INFO - 'cart']}, 13:51:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tp5o']}, 13:51:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['tp5o']}, 13:51:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s', 13:51:18 INFO - '--xperf_path', 13:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:18 INFO - 'tests': ['tp5n']}, 13:51:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--xperf_path', 13:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:18 INFO - 'tests': ['tp5n']}}, 13:51:18 INFO - 'talos.zip': {'path': '', 13:51:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:18 INFO - Running post-action listener: _resource_record_post_action 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.356873Z] Finished populate-webroot step (success) 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.357008Z] Running create-virtualenv step. 13:51:18 INFO - Running pre-action listener: _resource_record_pre_action 13:51:18 INFO - Running main action method: create_virtualenv 13:51:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:18 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 13:51:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:18 INFO - Using real prefix '/tools/python27' 13:51:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:22 INFO - Installing pip.................done. 13:51:22 INFO - Return code: 0 13:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:22 INFO - Reading from file tmpfile_stdout 13:51:22 INFO - Output received: 13:51:22 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) 13:51:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51: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', 'pip>=1.5'] in /builds/slave/test/build 13:51: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 pip>=1.5 13:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:22 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:22 INFO - 'USER': 'cltbld', 13:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:22 INFO - 'XPC_FLAGS': '0x0', 13:51:22 INFO - 'XPC_SERVICE_NAME': '0', 13:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:22 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 13:51:22 INFO - Cleaning up... 13:51:22 INFO - Return code: 0 13:51:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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', '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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:51: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 psutil>=3.1.1 13:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:22 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:22 INFO - 'USER': 'cltbld', 13:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:22 INFO - 'XPC_FLAGS': '0x0', 13:51:22 INFO - 'XPC_SERVICE_NAME': '0', 13:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:23 INFO - Downloading/unpacking psutil>=3.1.1 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:27 INFO - Installing collected packages: psutil 13:51:27 INFO - Running setup.py install for psutil 13:51:27 INFO - building 'psutil._psutil_osx' extension 13:51:27 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 13:51:27 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 13:51:27 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 13:51:27 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 13:51:27 INFO - building 'psutil._psutil_posix' extension 13:51:27 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 13:51:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:27 INFO - ^ 13:51:27 INFO - 1 warning generated. 13:51:27 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 13:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:28 INFO - Successfully installed psutil 13:51:28 INFO - Cleaning up... 13:51:28 INFO - Return code: 0 13:51:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:28 INFO - 'HOME': '/Users/cltbld', 13:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:28 INFO - 'LOGNAME': 'cltbld', 13:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:28 INFO - 'MOZ_NO_REMOTE': '1', 13:51:28 INFO - 'NO_EM_RESTART': '1', 13:51:28 INFO - 'PAGER': '/bin/cat', 13:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:28 INFO - 'PWD': '/builds/slave/test', 13:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:28 INFO - 'SHELL': '/bin/bash', 13:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:28 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:28 INFO - 'USER': 'cltbld', 13:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:28 INFO - 'XPC_FLAGS': '0x0', 13:51:28 INFO - 'XPC_SERVICE_NAME': '0', 13:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51:28 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 13:51:28 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 13:51:28 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 13:51:28 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 13:51:28 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 13:51:28 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 13:51:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:31 INFO - Installing collected packages: mozsystemmonitor 13:51:31 INFO - Running setup.py install for mozsystemmonitor 13:51:31 INFO - Successfully installed mozsystemmonitor 13:51:31 INFO - Cleaning up... 13:51:31 INFO - Return code: 0 13:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:31 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')]} 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:31 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')]} 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:31 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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:31 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 13:51:31 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 13:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:31 INFO - 'HOME': '/Users/cltbld', 13:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:31 INFO - 'LOGNAME': 'cltbld', 13:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:31 INFO - 'MOZ_NO_REMOTE': '1', 13:51:31 INFO - 'NO_EM_RESTART': '1', 13:51:31 INFO - 'PAGER': '/bin/cat', 13:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:31 INFO - 'PWD': '/builds/slave/test', 13:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:31 INFO - 'SHELL': '/bin/bash', 13:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:31 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:31 INFO - 'USER': 'cltbld', 13:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:31 INFO - 'XPC_FLAGS': '0x0', 13:51:31 INFO - 'XPC_SERVICE_NAME': '0', 13:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:34 INFO - warning: no files found matching '*.txt' 13:51:34 INFO - no previously-included directories found matching 'build' 13:51:34 INFO - no previously-included directories found matching 'dist' 13:51:34 INFO - no previously-included directories found matching '.git*' 13:51:34 INFO - Installing collected packages: jsonschema, functools32 13:51:34 INFO - Running setup.py install for functools32 13:51:34 INFO - warning: no files found matching '*.txt' 13:51:34 INFO - no previously-included directories found matching 'build' 13:51:34 INFO - no previously-included directories found matching 'dist' 13:51:34 INFO - no previously-included directories found matching '.git*' 13:51:34 INFO - Successfully installed jsonschema functools32 13:51:34 INFO - Cleaning up... 13:51:34 INFO - Return code: 0 13:51:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:35 INFO - 'HOME': '/Users/cltbld', 13:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PAGER': '/bin/cat', 13:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:35 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - 'XPC_FLAGS': '0x0', 13:51:35 INFO - 'XPC_SERVICE_NAME': '0', 13:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:35 INFO - 'HOME': '/Users/cltbld', 13:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PAGER': '/bin/cat', 13:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:35 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - 'XPC_FLAGS': '0x0', 13:51:35 INFO - 'XPC_SERVICE_NAME': '0', 13:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:35 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 13:51:35 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 13:51:35 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 13:51:35 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 13:51:35 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 13:51:35 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 13:51:38 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 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 13:51:38 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 13:51:39 INFO - Downloading docopt-0.6.1.tar.gz 13:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:39 INFO - Running setup.py install for blobuploader 13:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:39 INFO - Running setup.py install for requests 13:51:39 INFO - Running setup.py install for docopt 13:51:40 INFO - Successfully installed blobuploader requests docopt 13:51:40 INFO - Cleaning up... 13:51:40 INFO - Return code: 0 13:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:40 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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:40 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 13:51:40 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 13:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:40 INFO - 'HOME': '/Users/cltbld', 13:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:40 INFO - 'LOGNAME': 'cltbld', 13:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:40 INFO - 'MOZ_NO_REMOTE': '1', 13:51:40 INFO - 'NO_EM_RESTART': '1', 13:51:40 INFO - 'PAGER': '/bin/cat', 13:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:40 INFO - 'PWD': '/builds/slave/test', 13:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:40 INFO - 'SHELL': '/bin/bash', 13:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:40 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:40 INFO - 'USER': 'cltbld', 13:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:40 INFO - 'XPC_FLAGS': '0x0', 13:51:40 INFO - 'XPC_SERVICE_NAME': '0', 13:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-tTe_u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-L8_o43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-oeKxAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-8eUVuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:40 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-pbSFC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:40 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-fFgkz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ceH22_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-1TK28U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-kIFbMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ofD50J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-X7Z1oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-3PeIEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-HESJZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-nrUpUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:41 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-jhrOEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:42 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-rTbybl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:42 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-OvG9fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:42 INFO - Running setup.py install for manifestparser 13:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozcrash 13:51:42 INFO - Running setup.py install for mozdebug 13:51:42 INFO - Running setup.py install for mozdevice 13:51:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:42 INFO - Running setup.py install for mozfile 13:51:42 INFO - Running setup.py install for mozhttpd 13:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozinfo 13:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozInstall 13:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozleak 13:51:43 INFO - Running setup.py install for mozlog 13:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for moznetwork 13:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozprocess 13:51:44 INFO - Running setup.py install for mozprofile 13:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for mozrunner 13:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for mozscreenshot 13:51:44 INFO - Running setup.py install for moztest 13:51:44 INFO - Running setup.py install for mozversion 13:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:44 INFO - Cleaning up... 13:51:44 INFO - Return code: 0 13:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:44 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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:44 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 13:51:44 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 13:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:44 INFO - 'HOME': '/Users/cltbld', 13:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:44 INFO - 'LOGNAME': 'cltbld', 13:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:44 INFO - 'MOZ_NO_REMOTE': '1', 13:51:44 INFO - 'NO_EM_RESTART': '1', 13:51:44 INFO - 'PAGER': '/bin/cat', 13:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:44 INFO - 'PWD': '/builds/slave/test', 13:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:44 INFO - 'SHELL': '/bin/bash', 13:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:44 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:44 INFO - 'USER': 'cltbld', 13:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:44 INFO - 'XPC_FLAGS': '0x0', 13:51:44 INFO - 'XPC_SERVICE_NAME': '0', 13:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ghLaKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-H8YX08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-XUdJ49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-AxsZsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-LtSZ_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-f6ajHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-mHPorO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:45 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)) 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:45 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-N16Vug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-yJSxSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-jKsmzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-4XZBun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-4cl6UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-OHlCnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-NF2QLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-2mvFzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:46 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-bQLNeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 13:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:46 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-01UQae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:46 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)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:51:46 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)) 13:51:46 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)) 13:51:46 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)) 13:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:49 INFO - Downloading blessings-1.6.tar.gz 13:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:49 INFO - Installing collected packages: blessings 13:51:49 INFO - Running setup.py install for blessings 13:51:49 INFO - Successfully installed blessings 13:51:49 INFO - Cleaning up... 13:51:49 INFO - Return code: 0 13:51:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Current package versions: 13:51:50 INFO - blessings == 1.6 13:51:50 INFO - blobuploader == 1.2.4 13:51:50 INFO - docopt == 0.6.1 13:51:50 INFO - functools32 == 3.2.3-2 13:51:50 INFO - jsonschema == 2.5.1 13:51:50 INFO - manifestparser == 1.1 13:51:50 INFO - mozInstall == 1.12 13:51:50 INFO - mozcrash == 0.17 13:51:50 INFO - mozdebug == 0.1 13:51:50 INFO - mozdevice == 0.48 13:51:50 INFO - mozfile == 1.2 13:51:50 INFO - mozhttpd == 0.7 13:51:50 INFO - mozinfo == 0.9 13:51:50 INFO - mozleak == 0.1 13:51:50 INFO - mozlog == 3.4 13:51:50 INFO - moznetwork == 0.27 13:51:50 INFO - mozprocess == 0.23 13:51:50 INFO - mozprofile == 0.28 13:51:50 INFO - mozrunner == 6.12 13:51:50 INFO - mozscreenshot == 0.1 13:51:50 INFO - mozsystemmonitor == 0.3 13:51:50 INFO - moztest == 0.7 13:51:50 INFO - mozversion == 1.4 13:51:50 INFO - psutil == 3.1.1 13:51:50 INFO - requests == 1.2.3 13:51:50 INFO - wsgiref == 0.1.2 13:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:50 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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:50 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 13:51:50 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 13:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:50 INFO - 'HOME': '/Users/cltbld', 13:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:50 INFO - 'LOGNAME': 'cltbld', 13:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:50 INFO - 'MOZ_NO_REMOTE': '1', 13:51:50 INFO - 'NO_EM_RESTART': '1', 13:51:50 INFO - 'PAGER': '/bin/cat', 13:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:50 INFO - 'PWD': '/builds/slave/test', 13:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:50 INFO - 'SHELL': '/bin/bash', 13:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:50 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:50 INFO - 'USER': 'cltbld', 13:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:50 INFO - 'XPC_FLAGS': '0x0', 13:51:50 INFO - 'XPC_SERVICE_NAME': '0', 13:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 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)) 13:51:50 INFO - Cleaning up... 13:51:50 INFO - Return code: 0 13:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:50 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 0x100a68490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc318c6d9d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, '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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 13:51:50 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 13:51:50 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 13:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:50 INFO - 'HOME': '/Users/cltbld', 13:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:50 INFO - 'LOGNAME': 'cltbld', 13:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:50 INFO - 'MOZ_NO_REMOTE': '1', 13:51:50 INFO - 'NO_EM_RESTART': '1', 13:51:50 INFO - 'PAGER': '/bin/cat', 13:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:50 INFO - 'PWD': '/builds/slave/test', 13:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:50 INFO - 'SHELL': '/bin/bash', 13:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:51:50 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:50 INFO - 'USER': 'cltbld', 13:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:50 INFO - 'XPC_FLAGS': '0x0', 13:51:50 INFO - 'XPC_SERVICE_NAME': '0', 13:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:50 INFO - Cleaning up... 13:51:50 INFO - Return code: 0 13:51:50 INFO - Running post-action listener: _resource_record_post_action 13:51:50 INFO - Running post-action listener: _start_resource_monitoring 13:51:50 INFO - Starting resource monitoring. 13:51:50 INFO - [mozharness: 2016-10-26 20:51:50.749502Z] Finished create-virtualenv step (success) 13:51:50 INFO - [mozharness: 2016-10-26 20:51:50.750581Z] Running install step. 13:51:50 INFO - Running pre-action listener: _resource_record_pre_action 13:51:50 INFO - Running main action method: install 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:51 INFO - Reading from file tmpfile_stdout 13:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:51 INFO - Reading from file tmpfile_stdout 13:51:51 INFO - Output received: 13:51:51 INFO - Usage: mozinstall [options] installer 13:51:51 INFO - Options: 13:51:51 INFO - -h, --help show this help message and exit 13:51:51 INFO - -d DEST, --destination=DEST 13:51:51 INFO - Directory to install application into. [default: 13:51:51 INFO - "/builds/slave/test"] 13:51:51 INFO - --app=APP Application being installed. [default: firefox] 13:51:51 INFO - mkdir: /builds/slave/test/build/application 13:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:52:25 INFO - Reading from file tmpfile_stdout 13:52:25 INFO - Output received: 13:52:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:25 INFO - Running post-action listener: _resource_record_post_action 13:52:25 INFO - [mozharness: 2016-10-26 20:52:25.255166Z] Finished install step (success) 13:52:25 INFO - [mozharness: 2016-10-26 20:52:25.255330Z] Running run-tests step. 13:52:25 INFO - Running pre-action listener: _resource_record_pre_action 13:52:25 INFO - Running main action method: run_tests 13:52:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:25 INFO - 2016-10-26 13:52:25.270 screenresolution[1645:8219] starting screenresolution argv=screenresolution get 13:52:25 INFO - 2016-10-26 13:52:25.272 screenresolution[1645:8219] Display 0: 1600x1200x32@60 13:52:25 INFO - 2016-10-26 13:52:25.280 screenresolution[1646:8221] starting screenresolution argv=screenresolution list 13:52:25 INFO - Available Modes on Display 0 13:52:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:25 INFO - Intel Iris: 13:52:25 INFO - Chipset Model: Intel Iris 13:52:25 INFO - Type: GPU 13:52:25 INFO - Bus: Built-In 13:52:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:25 INFO - Vendor: Intel (0x8086) 13:52:25 INFO - Device ID: 0x0a2e 13:52:25 INFO - Revision ID: 0x0009 13:52:25 INFO - Displays: 13:52:25 INFO - Display: 13:52:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:25 INFO - Display Serial Number: 1600x1200 60 13:52:25 INFO - Main Display: Yes 13:52:25 INFO - Mirror: Off 13:52:25 INFO - Online: Yes 13:52:25 INFO - Rotation: Supported 13:52:25 INFO - Return code: 0 13:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:25 INFO - Python 2.7.3 13:52:25 INFO - Return code: 0 13:52:25 INFO - grabbing minidump binary from tooltool 13:52:25 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')]} 13:52:25 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 0x10087cd30>, '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 0x1006a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100874b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:25 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 13:52:25 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 13:52:25 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 13:52:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:25 INFO - Return code: 0 13:52:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0322 --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 13:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yD3MSD4vLm/Render', 13:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:25 INFO - 'HOME': '/Users/cltbld', 13:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:25 INFO - 'LOGNAME': 'cltbld', 13:52:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:25 INFO - 'MOZ_NO_REMOTE': '1', 13:52:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:25 INFO - 'NO_EM_RESTART': '1', 13:52:25 INFO - 'PAGER': '/bin/cat', 13:52:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:25 INFO - 'PWD': '/builds/slave/test', 13:52:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:25 INFO - 'SHELL': '/bin/bash', 13:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eIn2pjRQ2G/Listeners', 13:52:25 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 13:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:25 INFO - 'USER': 'cltbld', 13:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:25 INFO - 'XPC_FLAGS': '0x0', 13:52:25 INFO - 'XPC_SERVICE_NAME': '0', 13:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 13:52:25 INFO - mozversion application_buildid: 20161026075526 13:52:25 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:25 INFO - mozversion application_display_name: Nightly 13:52:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:25 INFO - mozversion application_name: Firefox 13:52:25 INFO - mozversion application_remotingname: firefox 13:52:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:25 INFO - mozversion application_vendor: Mozilla 13:52:25 INFO - mozversion application_version: 52.0a1 13:52:25 INFO - mozversion platform_buildid: 20161026075526 13:52:25 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:25 INFO - mozversion platform_version: 52.0a1 13:52:25 INFO - using testdate: 1477515145 13:52:25 INFO - actual date: 1477515145 13:52:25 INFO - starting webserver on 'localhost:49274' 13:52:25 INFO - SUITE-START | Running 2 tests 13:52:25 INFO - TEST-START | dromaeo_css 13:52:25 INFO - operating with platform_type : mac_ 13:52:25 INFO - Initialising browser for dromaeo_css test... 13:52:25 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpeKfzDH/profile http://localhost:49274/getInfo.html) 13:52:28 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 13:52:28 INFO - PROCESS | 1656 | colorDepth:24 13:52:28 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 13:52:28 INFO - PROCESS | 1656 | __metrics 13:52:28 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:52:28 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:29 INFO - TEST-INFO | 1656: exit 0 13:52:29 INFO - Browser initialized. 13:52:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:29 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpeKfzDH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:41 INFO - PROCESS | 1659 | RSS: Main: 231497728 13:52:41 INFO - PROCESS | 1659 | 13:53:31 INFO - PROCESS | 1659 | 1477515211772 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:55:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 13:55:47 INFO - PROCESS | 1659 | RSS: Main: 412635136 13:55:47 INFO - PROCESS | 1659 | 13:58:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 13:58:50 INFO - PROCESS | 1659 | RSS: Main: 369721344 13:58:50 INFO - PROCESS | 1659 | 14:01:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 14:01:53 INFO - PROCESS | 1659 | RSS: Main: 338751488 14:01:53 INFO - PROCESS | 1659 | 14:04:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 14:04:57 INFO - PROCESS | 1659 | RSS: Main: 360079360 14:04:57 INFO - PROCESS | 1659 | 14:08:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 14:08:00 INFO - PROCESS | 1659 | RSS: Main: 336224256 14:08:00 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 14:11:04 INFO - PROCESS | 1659 | RSS: Main: 402460672 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | __start_tp_report 14:11:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 14:11:04 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 14:11:04 INFO - PROCESS | 1659 | |i|pagename|runs| 14:11:04 INFO - PROCESS | 1659 | |0;dojo.html;3176.4917613181888;3333.616634087079;3371.443711787555;3381.0702056934356;3384.120128766521;5571.693556854371;5672.602917795756;5723.9713801431035;5758.5393168546525;5761.107028410593;5659.801906933259;5668.744906479208;5740.052891272935;5778.335491418488;5816.302043754756;4269.487661480626;5158.9742051289695;5168.483151684839;5194.896102077956;5199;5178.715170665612;5257.053730328539;5289.074411977907;5307;5315.441878602749;5116.872078198037;5269.499397557226;5270;5295.920561191585;5362.8123015694455;5122.33409656746;5188.351456067991;5197.350331208599;5199.454057324002;5205.609579281569;4310.504292006397;5077.162268225738;5143.511366420222;5157.974210128926;5174.689518628894;5677.943220567783;5737.913931291034;5742.454466825645;5747.023006088975;5750.913736293917;6117.969410152965;6208.720607572625;6213.782517611907;6214.161088253073;6227.314995350508;6238.251409830804;6307.211598550181;6321;6326.335734747831;6344.49244060474;5816.389279125673;5821.7380217890295;5832.795852145239;5838.795642152504;5840.269966254218;6236.688165591702;6271.184745982993;6276.780312689034;6294.748210071546;6303.243610766645;6082.753035627686;6088.948840530829;6119.106526814625;6145.692715364214;6153.4154255345675;6294.9685251574365;6298.08677741734;6303.684815759194;6317.14718513004;6335.873282534416;6223.96888015557;6243.531735119885;6264.404881536247;6268.529860260499;6270.247570291503;6100.157317757059;6165.599236049642;6169.537284703665;6175.135481032659;6293.087502312231;4868.269759536027;4884.535969082932;4935.703857768545;4941.728204948762;4955.157623204064;4408.31671090975;4413.3821265022925;4422.115576884636;4452.1763473757455;4452.666050046195;5836.737346819404;5845.09401042839;5864.120381942743;5866.384029676908;5902.970485147547;6164.753409863645;6186.783462578788;6235.095911092866;6243.7814676486105;6336.334684858116;5812.796552120655;5858.326292476335;5866.6186697864505;5905.527557795366;5910.763569457259;5379.596530260246;5391.78432862689;5395.81114660985;5397.73011349431;5398.028354896078;6195.597286176384;6204.3795620437595;6206.813795585959;6270.4670103039925;6292.968535157478;6212.502999760099;6240.906386404298;6269.686515674107;6295.307516173126;6309.4952403806665;6293.968530157503;6296.150019747275;6305.1172835803945;6309.968450157719;6318.052292156213;6177.81466556004;6192.102145189013;6196.659183744757;6214.564980451506;6230.06549017651;6140.907886381798;6150.231221097363;6204.286507051746;6226.564140510302;6312.968435157794;6158.414950579688;6182.505399568114;6201.379862013762;6204.13142160089;6205.565610407409;5902.734376952962;6138.987067133873;6140.846478838065;6143.631382117087;6154.907676384947;5820.476157145878;5895.882082358415;5967.940320596738;6019.006863867413;6054.697265136638;6087;6149.554854609252;6156.07658851158;6156.938430615636;6162.537809664203;5794.797182098607;5864.618799778001;6007.098935159761;6024.457798798129;6056 14:11:04 INFO - PROCESS | 1659 | |1;ext.html;472.7163701778933;515.060015471764;527.6886636884238;531.0865311663937;540.4595404595404;26099.34751631208;31093.99999999997;31141;31158.532622010658;38314.233715325674;38288.23423531534;40365;40470.190596188135;40546.78359649208;40644;9487.620495180185;9675.516224188797;9681.903180968206;9687.709368718915;9703.126718595326;8441.620127094295;8541.658333666677;8766.6931657392;9363.625454981793;11276.54893804251;11447.885521144764;11579.594714185005;11582.6525204244;11593.594224202154;11652.475638596241;11488.942555287254;11532.308061516253;11544.76910461786;11559.711007224803;11569.595064172714;7453.180150183475;7609.7336593219525;8726;8792.34057445694;11343.602973895873;31163.376732465225;38326.42510362347;39006.02484937871;39055;40180.79909600462;2922.7077292270815;3293.766330720418;3469.9479507807405;3507.5966263879727;4056.9797151014054;24812.50374992508;29198;29667.70332296671;30831.84584077088;30895.845520772476;3057.8929737459084;3182.6499085100622;3193.9840300798346;3232.628247751515;3236.1585987643384;478599.6070019662;481879;486483;493506;497766;58321.708391457774;60494.697526512085;60648.696756516816;60748.69625651932;60836.087458688155;63401.731965360435;63519;63571;63707.681461592394;63718.36281637217;15728.05631662104;15904.602384940468;15911.363545458284;15914.840851591336;15947.60130996711;12253.877461225451;12299.93850030744;12305.50777968889;12313.630591082281;12346.75306493883;15186.772198417033;16260.430884918971;16395.672086558203;16652.50042498727;16721.83278167227;7203.8559228816175;7644.96792932958;7937.404694647925;8053.7114061749835;8058;929.4376901974343;962.8074385123003;975.987914447003;994.2841154368842;999.5152351109706;28777.95662910812;29371.853140734587;29543.852280738458;30235.848820755757;31201.21996950049;1030.907218350352;1039.4127318065268;1052.5368837711383;1060.3372891942536;1108.8336749487642;14529.78205326921;15237.542873713806;15365.539033829004;15530.767038494432;15641.061536307858;643448;648522;648954;649978;650378;49118.280860169725;49896.750516247914;55438.72280638652;56623.43376566264;56749.71625141848;1323.2060763541797;1354.850966393696;1364.5496985994598;1366.2349084512507;1370.3216907630785;30084.398312034074;30380.544291836082;31053.8447307762;31715.048548543582;32624;54752.726236368566;55317.44682553123;55421;55578;55681.60795980133;601064;603899;605125.8718532072;606279;606403;26132.477350453264;26722.465550689267;26824;41375.37936931009;42001.78999104985;45497.31754023626;46754.53245467502;46838;46980.59058228259;47482;38237.426438604;38258;38603.411196892106;39423;39541.60458395494;35496.29007419785;38039.80980095082;38299;38976.41535377028;39529.61646342364;37145.628543714214;37251.25497490089;37440.6255937448;37920.24159516739;38057.80971095237;30941.381172375975;32762;33401.49897751584;34411.13972150616;34437.827810860785;22926.42683932915;23419.765802341757;24960.37599060038;24965.50068998646;25730 14:11:04 INFO - PROCESS | 1659 | |2;jquery.html;336.5204583468557;346.0242117229411;356.1914454188991;367.28379659663653;371.8624109079639;13292.46830126795;15132.924335378308;16207.027578345307;17409;20457.283995060177;17522.82477175228;20628.69056964143;20657.38027859163;20987.685184722202;21193.894030529864;5772.365039845603;6050.788222412217;6164.044573091178;6172.22847144107;6173.506119510451;4753.762311884409;6083.634981901078;6778.389944904958;6864.828379290508;6928.411085057776;5429.891402171954;6856;6857.931420685804;6861.27956564561;6863.553868998524;5932.11018347247;6054.909176362358;6078.966575682145;6087.056506241495;6089.969550152266;5794;5836.095405212199;5884.735186916599;5901.940980590182;5963.224780778514;13472.461101555926;13708.52020179299;13712.65718357039;18886.52783680419;25703.10039148621;1788.847947924428;2111.9155233790784;2688.7714544263763;2759.7930155238237;2893.204368798576;10257.692269231935;12346.074044446703;12686;15817.841821581753;15821.208939552977;1779.80422153563;1813.3925135079764;1819.2120724106046;1831.9740945070669;1940.0590713503939;115234;124049.75950240472;125500;125522.37238813748;126522.36738816339;10977.780444391226;11346.773064538664;11378;11520.366379849189;11889.405529723479;12791.296478693575;14504.782428263585;14509.637259068397;14512.346944387316;14526.709465810836;7275.563466192046;8190.140035296327;8464.44981076228;8599.828003439896;8611.397202195787;6725.831854203684;8008.676399294228;8029.7189598363775;8428.873566896502;8459.661613535513;4476.9104617908115;4477.417935668343;4486.237339652267;4489.528599497071;4589.65577581676;1668.8568330693513;1864.7016477363827;1903.1340739963284;1918.856085793571;1929.2861641192849;870.9695160669346;902.354816306331;964.3346091197052;1011.0193112680688;1043.436544266103;18703.81296187048;18952.52618684544;19757.604847902963;20121.899390502953;21619.895731996497;925.4817302310728;942.0767647705287;949.7293271417612;970.3256236915418;983.9409635421897;10546.314489558154;10929.672109836718;11143.609973651046;11159.888401116048;11176.385298808482;470244;477534;479061;591409;597947;127272;145443;146615.26692366684;148623;151704.2414787919;858.3690987124459;874.0560194989523;930.464982634974;986.8223719730374;989.5942663507927;15682.451114211404;18804;19637.50906227356;19684;19752.604947901247;54547.454525455825;55093.62265943223;56414.71792641011;56833.71583142058;57097.85804283974;74687.2531274702;77679;78778;80127.59936200282;80805;11971.14447260676;11980.58067967617;12172.634820955385;12695.111342205957;12784.424700888296;13129.540466083641;13296.268705220918;13470.528531501743;14044.929775351058;14319.35562899693;11627;11764.941175294069;11837.585684501;12106.213096148722;12181.512739490321;11704.473298701409;11745.001674857733;11905.464254108412;12069.456874440846;12264.202826816228;10920.563177472812;11400.828987565359;11844.23012504219;12118.515259389525;12227.938860305641;12486.313252770822;12510.249385036926;12786.232826030468;12821.487140514275;12877.935610321889;11616.186866919235;11743.706407339885;11995.82006269924;12055.879441205827;12202.633920982385 14:11:04 INFO - PROCESS | 1659 | |3;mootools.html;1361.8978576606758;1504.2779465856393;1558.3221298735052;1768.893866368018;1936.6804477261253;7062.964685176574;7761.534307941528;8734.563271836414;8750.474971501715;8877.55612219388;8643.0924752901;8689;8713.215810577047;8716.60775265113;8726.345524085687;2304.158981971581;2333.3116730564525;2334.3580515358244;2335.2994101769486;2337.91817286395;2312.4450131968374;2356.446235134742;2369.9052037918464;2370.3481542575755;2372.1697405907967;2291.713535808024;2304.7234331880113;2330.33585428153;2334.9066037358484;2343.7773411525877;2271.46620544172;2279.179495381661;2294.804941579959;2309.2148669452467;2315.2128276385943;2309.3187509684685;2327.476317828492;2334.9066037358657;2337.7662233776655;2337.836351455399;8633.481991080555;8705.521196334199;8751.212390884852;8770.210681038674;8775.561221938877;4619.19164146273;5189.766460509286;5199.090159222121;5386.946130538684;5396.838094857121;3355.983220083884;3528;3530.3998320285614;3599.3881040223223;3607.549056367954;949.5015117063527;986.3046552180696;1018.6485662446444;1022.044388496758;1029.12524354299;11366.204365694404;11398.715032124263;11473.942630286962;11491.597794077166;11496.425178741114;4311.6335111515245;4442.911141777211;4522.23122069249;4525.954740452619;4528.705634133771;9000.549972501349;9007.414518056305;9018.368714189945;9026.86459703105;9032;5168.767405466763;5241.397239317451;5244.265802787613;5245.790168393221;5251.264822924793;4421.40311058003;4537.3647689323525;4757.167495688241;4911.705297682151;4957.504249575086;3595.280943811248;3622.8550857965915;3713.9814300928324;3728.422094575345;3763.1156678180605;1127.3799410324452;1135.5401062569672;1136.2046567402685;1146.529922731676;1151.3552410649895;750.3696894608555;819.2872201185007;884.8230353929112;922.6632279218171;975.0395860077817;5711.771529138871;5722.4277572242445;5744.454276843693;5881.705914704247;6088.512918966472;880.264978742757;909.4857062990179;927.2674587076134;951.1962391778935;1021.6781713760141;3347.911928623207;3909.8045097745567;3915.5888631693833;4008.939865902014;4035.757854528738;10327.586896524055;10726.088282495919;10733.08768754649;10736.624218152327;10754.193435492212;10524.579016839394;10695.465226738632;10696.946515267375;10705.9464702676;10718.732031699114;7743.5353878767455;8089.069756977905;8162.591870406574;8166.632501537445;8242.381821363302;5700.372958974426;5808.738606762621;5812.273465816773;5931;5973.522118230618;9814.509274536102;9948.950255248677;9987.900120998696;10007.649732259337;10020;9777.511124443607;9921.503924803876;10085.092341689284;10190.286679932333;10205.489725513844;6720.126383570105;6920.134983127109;6932.549384290005;7146.678399471933;7357.889631655423;7854.136045035156;7923.920760792318;7938.404619653434;7941.8411631768195;8153.714619988272;6453.903191452038;7208.603526805866;7383.741569045058;7394.55632662042;7503.324700776956;7264.600446975467;7291.598962057138;7292.781216563511;7298.051253337032;7331.450141239322;6799.524033317621;6905.378515933389;6930.792076237721;6942.375186233263;6955.652217389212;4317.352397140454;4914.663568939315;5004.524570165829;5042.84871453857;5137.5889928806355;4943.826966056171;4970.826021089245;5043.9747801260755;5133.973205359018;5209.6874187548865 14:11:04 INFO - PROCESS | 1659 | |4;prototype.html;272.38069675777496;292.1483874505814;293.64762285257683;314.59731543624156;317.1389677026872;5376.489233522814;5398.6490878092945;5415.783368665248;5435.266239057726;5481.5340696040785;4677.462091859437;5167.819126330579;5202.8699282517955;5234.18870075138;5317.229001794737;4051.615096565836;4054.4526488923984;4062.7156099073077;4087.5912408759036;4091.5703851095654;3454.4990976308422;4091.4272001919753;4113.218488487193;4134.937975930364;4138.793060346986;3373.510840928076;3734.701223902095;3920.8823735287842;4037.555868854424;4066.4916885389325;3960.386140148282;3973.7417067890497;3991.820368083443;4002.0995276062945;4025.2754504189234;3061.7397521210723;3206.2144774530157;3467.8959631211105;3489.028698785178;3493.336266109431;4872.926906096412;5208.869778255536;5216.765245563959;5264.210368444764;5272.868178295574;3975.052224410047;4454.777261136963;4565.338025986247;4609.446866376023;4624.630029597624;5526.696031718254;5556.388797232301;5600.859978500529;5601.515598366436;5606.803761868356;3821.464994900716;3821.541415030214;3822.808859557039;3824.9235015299814;3857.1321452673205;5072.974635126838;5421.8885128548945;5537.556995440355;5723.796338409742;5911.379305172938;3732.3468393031653;3779.074126838942;3857.556381016163;3876.8449262029767;3887.8250478728523;3383.8815641452925;3499.61504234534;3745.501799280255;3861.3049651062515;3929.1945151243926;4262.552431994658;4417.646588272931;4453.643708503312;4578.9542104579195;4602.987342784582;5108.846734597968;5533.501984821385;5564.188530856376;5614.747336369873;5817.912731309034;1310.8689131086815;1332.2605953695793;1334.5929491505185;1339.5311640925793;1340.3633274194874;686.1526015371013;761.46316846623;781.4334607409696;820.3970081989733;827.5283088639538;4417.779111044435;4426.543268485957;4458.592360125561;4461.620762235247;4520.615747661485;4423.933640995388;4504.774761261924;4843.927341089887;4876;4899.485554016777;4360.738355698668;4424.646028317791;4430.82276708928;4462.44219472566;4473.642108631302;2361.6575596538405;2532.341316437736;2538.619207118947;2558.8336758110663;2576.9871150644126;4197.845592462098;4692.741899195509;4713.434387873477;4714.339992401066;4964.404271487372;4557.453105627346;4702.576768090888;4776.928346074812;4877.170880950176;4913.803447862117;4367.410399596014;4387.42963414754;4707.270373092108;4861.034768791034;5004.9729859407;4253.532111467674;4489.595936365743;4580.381648477412;4595.299739096556;4856.368672072608;4327;4340.544242854455;4489.169503641837;4648.373069425674;4797.016611594685;4378.80295386702;5467.808626698046;6044.576879618385;6061.6666083365835;6069.393060693896;3083.6762139975876;3823.8279277432025;3844.000559854514;3876.4185372194397;3893.4743809585343;5888.234529511136;5893.882122357614;5904.940950590439;5910.911336329872;5914.556408269483;5353.411124776194;5621.74702138413;5666.546676265806;5668.461496157858;5679.943200567942;5437.619366644297;5663.895540369588;5670.886582268249;5673.858153546194;5677.687727175045;4651.930221046619;5242.449542798104;5400.891982160413;5508.173773933942;5610.607257491936;4978.950210497848;5656.660600363992;5661.084541461233;5670.262865827416;5671.262735844314;5539.667619942817;5568.721563921868;5572.247746554163;5576.944230557642;5594.9720251398485 14:11:04 INFO - PROCESS | 1659 | |5;yui.html;728.5956294256687;728.9453291003176;745.3850573277044;790.7746292306693;806.0971711682917;15063.472778452757;15411;15423.383064677413;15424.383024678998;15456.768148477782;11513;12558.99528037757;13874.959378046662;13916.443342266322;14285.428582856674;696.4880812602759;718.4073139659776;721.9784005632024;816.8529664660359;875.9080296568864;869.3653632848025;881.180502133016;885.4864178776327;886.5567216391804;889.1064480197425;912.6668765900465;914.4147745442922;928.2573940847329;949.5062567464914;951.0584521323874;735.4961851131992;758.6965213914423;940.8870935487716;941.7033634405175;942.5146049784366;677.2516369411778;694.7221111555418;699.4928676709396;700.2367419512705;701.1270967645263;14439.061461005002;14465.20441375724;14469;14494.130352178798;14498.492552760708;13017.414216360286;13125.86874131256;13227.404766785517;13237.007224458108;13374.398152083082;11898.940505297418;11956.402179891058;12057;12079.879201207963;12132.211406258564;3586.8923932282073;3709.4621279914263;4247.8300867965245;4316.007318316773;4452.710573812692;74524.88212676815;76119;88169;91394;91733.54133229358;7690.692372305157;10354.585816567404;10420.374777513374;10456;11417.48621312043;20029.899850500653;20284.290049848183;20306.49233769138;20312.76559578445;20417.69373459399;7551.471397002267;7562.735304264324;7626.656800443993;7673.808154796063;7711.730089446843;4149.431488919527;4255.8084886180195;4271.23117838792;4287;4368.8907777305185;3346.748993825473;3440.6559344065395;3447.052060683332;3729.720270979633;3940.645341919241;611.703323887914;700.8037749430167;708.3766285668579;709.1454796969639;714.4712912444858;634.6572850660684;642.9389208025231;678.7352932356386;679.6941376380549;681.8125015620744;8666.393352465393;9101.453912765255;9145.176934075966;9213.262938965001;9305.441673499612;550.9173623956358;581.4853854338941;589.381149792716;603.6589327030214;640.4044238857907;4614.215583350839;4629.77311012582;4730.905381892343;4843.346148270009;4926.359573255454;111972.44013780043;117823.03946565872;117945;118168;119921.40039299747;103917.8927266275;103949;105297;105707;106022;42123;56923.16153127031;63063;77811.61094194493;86214.56892715496;9663.000852090314;9673.181879018508;9729.805403891742;9735.1725103367;9754.31719779637;48863.5113648859;49432;51901.7404912973;53830.73084634552;54358;57888.710556446946;63240.36759632345;66860.33139668735;71739.64130179524;72996;12198.51205951752;12352.035511477001;12412.317322547347;12640.74718505643;13171.209727416386;13613.183209007491;14011.859881401055;14322.14067155974;14474;14625;12703.491860325854;12994.480220791062;13480.258585777485;13532;13572.93213533926;12805.487780488676;13125.934370328087;13248.536301229797;13720.588382348546;13820.23988680592;13006.674833129247;13095.41070651842;13128.146670466389;13387.665308367368;13456.798148027592;8489.87265191035;10567.471626418495;10729.141668666643;10902.781944361226;11226.101911846868;10565;11021.260270150267;11178.832317515082;11193.608223712132;11216.270942388719 14:11:04 INFO - PROCESS | 1659 | __end_tp_report 14:11:04 INFO - PROCESS | 1659 | __start_cc_report 14:11:04 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2079 14:11:04 INFO - PROCESS | 1659 | __end_cc_report 14:11:04 INFO - PROCESS | 1659 | __startTimestamp1477516264408__endTimestamp 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | ------- Summary: start ------- 14:11:04 INFO - PROCESS | 1659 | Number of tests: 6 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5754.55 Median:6019.01 stddev:663.02 (11.0%) stddev-sans-first:633.46 14:11:04 INFO - PROCESS | 1659 | Values: 3176.5 3333.6 3371.4 3381.1 3384.1 5571.7 5672.6 5724.0 5758.5 5761.1 5659.8 5668.7 5740.1 5778.3 5816.3 4269.5 5159.0 5168.5 5194.9 5199.0 5178.7 5257.1 5289.1 5307.0 5315.4 5116.9 5269.5 5270.0 5295.9 5362.8 5122.3 5188.4 5197.4 5199.5 5205.6 4310.5 5077.2 5143.5 5158.0 5174.7 5677.9 5737.9 5742.5 5747.0 5750.9 6118.0 6208.7 6213.8 6214.2 6227.3 6238.3 6307.2 6321.0 6326.3 6344.5 5816.4 5821.7 5832.8 5838.8 5840.3 6236.7 6271.2 6276.8 6294.7 6303.2 6082.8 6088.9 6119.1 6145.7 6153.4 6295.0 6298.1 6303.7 6317.1 6335.9 6224.0 6243.5 6264.4 6268.5 6270.2 6100.2 6165.6 6169.5 6175.1 6293.1 4868.3 4884.5 4935.7 4941.7 4955.2 4408.3 4413.4 4422.1 4452.2 4452.7 5836.7 5845.1 5864.1 5866.4 5903.0 6164.8 6186.8 6235.1 6243.8 6336.3 5812.8 5858.3 5866.6 5905.5 5910.8 5379.6 5391.8 5395.8 5397.7 5398.0 6195.6 6204.4 6206.8 6270.5 6293.0 6212.5 6240.9 6269.7 6295.3 6309.5 6294.0 6296.2 6305.1 6310.0 6318.1 6177.8 6192.1 6196.7 6214.6 6230.1 6140.9 6150.2 6204.3 6226.6 6313.0 6158.4 6182.5 6201.4 6204.1 6205.6 5902.7 6139.0 6140.8 6143.6 6154.9 5820.5 5895.9 5967.9 6019.0 6054.7 6087.0 6149.6 6156.1 6156.9 6162.5 5794.8 5864.6 6007.1 6024.5 6056.0 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:70905.47 Median:38147.62 stddev:156233.29 (409.5%) stddev-sans-first:156582.07 14:11:04 INFO - PROCESS | 1659 | Values: 472.7 515.1 527.7 531.1 540.5 26099.3 31094.0 31141.0 31158.5 38314.2 38288.2 40365.0 40470.2 40546.8 40644.0 9487.6 9675.5 9681.9 9687.7 9703.1 8441.6 8541.7 8766.7 9363.6 11276.5 11447.9 11579.6 11582.7 11593.6 11652.5 11488.9 11532.3 11544.8 11559.7 11569.6 7453.2 7609.7 8726.0 8792.3 11343.6 31163.4 38326.4 39006.0 39055.0 40180.8 2922.7 3293.8 3469.9 3507.6 4057.0 24812.5 29198.0 29667.7 30831.8 30895.8 3057.9 3182.6 3194.0 3232.6 3236.2 478599.6 481879.0 486483.0 493506.0 497766.0 58321.7 60494.7 60648.7 60748.7 60836.1 63401.7 63519.0 63571.0 63707.7 63718.4 15728.1 15904.6 15911.4 15914.8 15947.6 12253.9 12299.9 12305.5 12313.6 12346.8 15186.8 16260.4 16395.7 16652.5 16721.8 7203.9 7645.0 7937.4 8053.7 8058.0 929.4 962.8 976.0 994.3 999.5 28778.0 29371.9 29543.9 30235.8 31201.2 1030.9 1039.4 1052.5 1060.3 1108.8 14529.8 15237.5 15365.5 15530.8 15641.1 643448.0 648522.0 648954.0 649978.0 650378.0 49118.3 49896.8 55438.7 56623.4 56749.7 1323.2 1354.9 1364.5 1366.2 1370.3 30084.4 30380.5 31053.8 31715.0 32624.0 54752.7 55317.4 55421.0 55578.0 55681.6 601064.0 603899.0 605125.9 606279.0 606403.0 26132.5 26722.5 26824.0 41375.4 42001.8 45497.3 46754.5 46838.0 46980.6 47482.0 38237.4 38258.0 38603.4 39423.0 39541.6 35496.3 38039.8 38299.0 38976.4 39529.6 37145.6 37251.3 37440.6 37920.2 38057.8 30941.4 32762.0 33401.5 34411.1 34437.8 22926.4 23419.8 24960.4 24965.5 25730.0 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:33728.86 Median:10788.78 stddev:89280.95 (827.5%) stddev-sans-first:89496.20 14:11:04 INFO - PROCESS | 1659 | Values: 336.5 346.0 356.2 367.3 371.9 13292.5 15132.9 16207.0 17409.0 20457.3 17522.8 20628.7 20657.4 20987.7 21193.9 5772.4 6050.8 6164.0 6172.2 6173.5 4753.8 6083.6 6778.4 6864.8 6928.4 5429.9 6856.0 6857.9 6861.3 6863.6 5932.1 6054.9 6079.0 6087.1 6090.0 5794.0 5836.1 5884.7 5901.9 5963.2 13472.5 13708.5 13712.7 18886.5 25703.1 1788.8 2111.9 2688.8 2759.8 2893.2 10257.7 12346.1 12686.0 15817.8 15821.2 1779.8 1813.4 1819.2 1832.0 1940.1 115234.0 124049.8 125500.0 125522.4 126522.4 10977.8 11346.8 11378.0 11520.4 11889.4 12791.3 14504.8 14509.6 14512.3 14526.7 7275.6 8190.1 8464.4 8599.8 8611.4 6725.8 8008.7 8029.7 8428.9 8459.7 4476.9 4477.4 4486.2 4489.5 4589.7 1668.9 1864.7 1903.1 1918.9 1929.3 871.0 902.4 964.3 1011.0 1043.4 18703.8 18952.5 19757.6 20121.9 21619.9 925.5 942.1 949.7 970.3 983.9 10546.3 10929.7 11143.6 11159.9 11176.4 470244.0 477534.0 479061.0 591409.0 597947.0 127272.0 145443.0 146615.3 148623.0 151704.2 858.4 874.1 930.5 986.8 989.6 15682.5 18804.0 19637.5 19684.0 19752.6 54547.5 55093.6 56414.7 56833.7 57097.9 74687.3 77679.0 78778.0 80127.6 80805.0 11971.1 11980.6 12172.6 12695.1 12784.4 13129.5 13296.3 13470.5 14044.9 14319.4 11627.0 11764.9 11837.6 12106.2 12181.5 11704.5 11745.0 11905.5 12069.5 12264.2 10920.6 11400.8 11844.2 12118.5 12227.9 12486.3 12510.2 12786.2 12821.5 12877.9 11616.2 11743.7 11995.8 12055.9 12202.6 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5592.73 Median:5043.41 stddev:3140.26 (62.3%) stddev-sans-first:3132.97 14:11:04 INFO - PROCESS | 1659 | Values: 1361.9 1504.3 1558.3 1768.9 1936.7 7063.0 7761.5 8734.6 8750.5 8877.6 8643.1 8689.0 8713.2 8716.6 8726.3 2304.2 2333.3 2334.4 2335.3 2337.9 2312.4 2356.4 2369.9 2370.3 2372.2 2291.7 2304.7 2330.3 2334.9 2343.8 2271.5 2279.2 2294.8 2309.2 2315.2 2309.3 2327.5 2334.9 2337.8 2337.8 8633.5 8705.5 8751.2 8770.2 8775.6 4619.2 5189.8 5199.1 5386.9 5396.8 3356.0 3528.0 3530.4 3599.4 3607.5 949.5 986.3 1018.6 1022.0 1029.1 11366.2 11398.7 11473.9 11491.6 11496.4 4311.6 4442.9 4522.2 4526.0 4528.7 9000.5 9007.4 9018.4 9026.9 9032.0 5168.8 5241.4 5244.3 5245.8 5251.3 4421.4 4537.4 4757.2 4911.7 4957.5 3595.3 3622.9 3714.0 3728.4 3763.1 1127.4 1135.5 1136.2 1146.5 1151.4 750.4 819.3 884.8 922.7 975.0 5711.8 5722.4 5744.5 5881.7 6088.5 880.3 909.5 927.3 951.2 1021.7 3347.9 3909.8 3915.6 4008.9 4035.8 10327.6 10726.1 10733.1 10736.6 10754.2 10524.6 10695.5 10696.9 10705.9 10718.7 7743.5 8089.1 8162.6 8166.6 8242.4 5700.4 5808.7 5812.3 5931.0 5973.5 9814.5 9949.0 9987.9 10007.6 10020.0 9777.5 9921.5 10085.1 10190.3 10205.5 6720.1 6920.1 6932.5 7146.7 7357.9 7854.1 7923.9 7938.4 7941.8 8153.7 6453.9 7208.6 7383.7 7394.6 7503.3 7264.6 7291.6 7292.8 7298.1 7331.5 6799.5 6905.4 6930.8 6942.4 6955.7 4317.4 4914.7 5004.5 5042.8 5137.6 4943.8 4970.8 5044.0 5134.0 5209.7 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4341.91 Median:4599.14 stddev:1341.65 (29.2%) stddev-sans-first:1310.18 14:11:04 INFO - PROCESS | 1659 | Values: 272.4 292.1 293.6 314.6 317.1 5376.5 5398.6 5415.8 5435.3 5481.5 4677.5 5167.8 5202.9 5234.2 5317.2 4051.6 4054.5 4062.7 4087.6 4091.6 3454.5 4091.4 4113.2 4134.9 4138.8 3373.5 3734.7 3920.9 4037.6 4066.5 3960.4 3973.7 3991.8 4002.1 4025.3 3061.7 3206.2 3467.9 3489.0 3493.3 4872.9 5208.9 5216.8 5264.2 5272.9 3975.1 4454.8 4565.3 4609.4 4624.6 5526.7 5556.4 5600.9 5601.5 5606.8 3821.5 3821.5 3822.8 3824.9 3857.1 5073.0 5421.9 5537.6 5723.8 5911.4 3732.3 3779.1 3857.6 3876.8 3887.8 3383.9 3499.6 3745.5 3861.3 3929.2 4262.6 4417.6 4453.6 4579.0 4603.0 5108.8 5533.5 5564.2 5614.7 5817.9 1310.9 1332.3 1334.6 1339.5 1340.4 686.2 761.5 781.4 820.4 827.5 4417.8 4426.5 4458.6 4461.6 4520.6 4423.9 4504.8 4843.9 4876.0 4899.5 4360.7 4424.6 4430.8 4462.4 4473.6 2361.7 2532.3 2538.6 2558.8 2577.0 4197.8 4692.7 4713.4 4714.3 4964.4 4557.5 4702.6 4776.9 4877.2 4913.8 4367.4 4387.4 4707.3 4861.0 5005.0 4253.5 4489.6 4580.4 4595.3 4856.4 4327.0 4340.5 4489.2 4648.4 4797.0 4378.8 5467.8 6044.6 6061.7 6069.4 3083.7 3823.8 3844.0 3876.4 3893.5 5888.2 5893.9 5904.9 5910.9 5914.6 5353.4 5621.7 5666.5 5668.5 5679.9 5437.6 5663.9 5670.9 5673.9 5677.7 4651.9 5242.4 5400.9 5508.2 5610.6 4979.0 5656.7 5661.1 5670.3 5671.3 5539.7 5568.7 5572.2 5576.9 5595.0 14:11:04 INFO - PROCESS | 1659 | 14:11:04 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:20181.20 Median:4301.50 stddev:29797.51 (692.7%) stddev-sans-first:29845.31 14:11:04 INFO - PROCESS | 1659 | Values: 728.6 728.9 745.4 790.8 806.1 15063.5 15411.0 15423.4 15424.4 15456.8 11513.0 12559.0 13875.0 13916.4 14285.4 696.5 718.4 722.0 816.9 875.9 869.4 881.2 885.5 886.6 889.1 912.7 914.4 928.3 949.5 951.1 735.5 758.7 940.9 941.7 942.5 677.3 694.7 699.5 700.2 701.1 14439.1 14465.2 14469.0 14494.1 14498.5 13017.4 13125.9 13227.4 13237.0 13374.4 11898.9 11956.4 12057.0 12079.9 12132.2 3586.9 3709.5 4247.8 4316.0 4452.7 74524.9 76119.0 88169.0 91394.0 91733.5 7690.7 10354.6 10420.4 10456.0 11417.5 20029.9 20284.3 20306.5 20312.8 20417.7 7551.5 7562.7 7626.7 7673.8 7711.7 4149.4 4255.8 4271.2 4287.0 4368.9 3346.7 3440.7 3447.1 3729.7 3940.6 611.7 700.8 708.4 709.1 714.5 634.7 642.9 678.7 679.7 681.8 8666.4 9101.5 9145.2 9213.3 9305.4 550.9 581.5 589.4 603.7 640.4 4614.2 4629.8 4730.9 4843.3 4926.4 111972.4 117823.0 117945.0 118168.0 119921.4 103917.9 103949.0 105297.0 105707.0 106022.0 42123.0 56923.2 63063.0 77811.6 86214.6 9663.0 9673.2 9729.8 9735.2 9754.3 48863.5 49432.0 51901.7 53830.7 54358.0 57888.7 63240.4 66860.3 71739.6 72996.0 12198.5 12352.0 12412.3 12640.7 13171.2 13613.2 14011.9 14322.1 14474.0 14625.0 12703.5 12994.5 13480.3 13532.0 13572.9 12805.5 13125.9 13248.5 13720.6 13820.2 13006.7 13095.4 13128.1 13387.7 13456.8 8489.9 10567.5 10729.1 10902.8 11226.1 10565.0 11021.3 11178.8 11193.6 11216.3 14:11:04 INFO - PROCESS | 1659 | -------- Summary: end -------- 14:11:04 INFO - PROCESS | 1659 | 14:11:05 INFO - TEST-INFO | 1659: exit 0 14:11:05 INFO - TEST-OK | dromaeo_css | took 1119196ms 14:11:05 INFO - TEST-START | kraken 14:11:05 INFO - operating with platform_type : mac_ 14:11:05 INFO - Initialising browser for kraken test... 14:11:05 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmph5VWiq/profile http://localhost:49274/getInfo.html) 14:11:07 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:11:07 INFO - PROCESS | 1664 | colorDepth:24 14:11:07 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:11:07 INFO - PROCESS | 1664 | __metrics 14:11:07 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:11:07 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:11:08 INFO - TEST-INFO | 1664: exit 0 14:11:08 INFO - Browser initialized. 14:11:08 INFO - Running cycle 1/1 for kraken test... 14:11:08 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmph5VWiq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:19 INFO - PROCESS | 1665 | RSS: Main: 230793216 14:11:19 INFO - PROCESS | 1665 | 14:11:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:23 INFO - PROCESS | 1665 | RSS: Main: 289898496 14:11:23 INFO - PROCESS | 1665 | 14:11:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 14:11:26 INFO - PROCESS | 1665 | RSS: Main: 291110912 14:11:26 INFO - PROCESS | 1665 | 14:11:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 14:11:30 INFO - PROCESS | 1665 | RSS: Main: 383102976 14:11:30 INFO - PROCESS | 1665 | 14:11:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 14:11:33 INFO - PROCESS | 1665 | RSS: Main: 284749824 14:11:33 INFO - PROCESS | 1665 | 14:11:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:36 INFO - PROCESS | 1665 | RSS: Main: 288907264 14:11:36 INFO - PROCESS | 1665 | 14:11:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:39 INFO - PROCESS | 1665 | RSS: Main: 326127616 14:11:39 INFO - PROCESS | 1665 | 14:11:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:42 INFO - PROCESS | 1665 | RSS: Main: 328241152 14:11:42 INFO - PROCESS | 1665 | 14:11:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 14:11:46 INFO - PROCESS | 1665 | RSS: Main: 326934528 14:11:46 INFO - PROCESS | 1665 | 14:11:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:48 INFO - PROCESS | 1665 | RSS: Main: 302686208 14:11:48 INFO - PROCESS | 1665 | 14:11:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:51 INFO - PROCESS | 1665 | RSS: Main: 304902144 14:11:51 INFO - PROCESS | 1665 | 14:11:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:53 INFO - PROCESS | 1665 | RSS: Main: 309583872 14:11:53 INFO - PROCESS | 1665 | 14:11:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:57 INFO - PROCESS | 1665 | RSS: Main: 319004672 14:11:57 INFO - PROCESS | 1665 | 14:12:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:01 INFO - PROCESS | 1665 | RSS: Main: 318951424 14:12:01 INFO - PROCESS | 1665 | 14:12:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 14:12:03 INFO - PROCESS | 1665 | RSS: Main: 363077632 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | __start_tp_report 14:12:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:12:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:12:03 INFO - PROCESS | 1665 | |i|pagename|runs| 14:12:03 INFO - PROCESS | 1665 | |0;ai-astar;110;114;114;113;114;114;113;112;113;113 14:12:03 INFO - PROCESS | 1665 | |1;audio-beat-detection;148;112;112;150;113;111;114;112;145;116 14:12:03 INFO - PROCESS | 1665 | |2;audio-dft;183;186;183;185;184;184;179;183;183;183 14:12:03 INFO - PROCESS | 1665 | |3;audio-fft;80;58;76;113;87;65;58;59;84;57 14:12:03 INFO - PROCESS | 1665 | |4;audio-oscillator;84;71;92;69;67;69;93;68;68;89 14:12:03 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;86;90;86;90;85;89;88;89;86 14:12:03 INFO - PROCESS | 1665 | |6;imaging-darkroom;94;94;95;94;94;93;96;94;94;94 14:12:03 INFO - PROCESS | 1665 | |7;imaging-desaturate;81;84;80;79;83;80;82;85;84;82 14:12:03 INFO - PROCESS | 1665 | |8;json-parse-financial;58;57;55;56;56;56;56;56;56;56 14:12:03 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;65;67;72;77;72;68;68;70;67;84 14:12:03 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;90;92;88;86;90;86;91;86;87;87 14:12:03 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;148;149;148;148;157;152;173;142;183;146 14:12:03 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;174;174;171;176;177;166;173;174;174;182 14:12:03 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;69;69;68;70;69;68;69;69;66;69 14:12:03 INFO - PROCESS | 1665 | __end_tp_report 14:12:03 INFO - PROCESS | 1665 | __start_cc_report 14:12:03 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2055 14:12:03 INFO - PROCESS | 1665 | __end_cc_report 14:12:03 INFO - PROCESS | 1665 | __startTimestamp1477516323194__endTimestamp 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:12:03 INFO - PROCESS | 1665 | Number of tests: 14 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.25 (1.1%) stddev-sans-first:0.71 14:12:03 INFO - PROCESS | 1665 | Values: 110.0 114.0 114.0 113.0 114.0 114.0 113.0 112.0 113.0 113.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:115.00 stddev:16.91 (14.7%) stddev-sans-first:15.40 14:12:03 INFO - PROCESS | 1665 | Values: 148.0 112.0 112.0 150.0 113.0 111.0 114.0 112.0 145.0 116.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.83 (1.0%) stddev-sans-first:1.94 14:12:03 INFO - PROCESS | 1665 | Values: 183.0 186.0 183.0 185.0 184.0 184.0 179.0 183.0 183.0 183.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:73.70 Median:70.50 stddev:18.06 (25.6%) stddev-sans-first:19.01 14:12:03 INFO - PROCESS | 1665 | Values: 80.0 58.0 76.0 113.0 87.0 65.0 58.0 59.0 84.0 57.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:11.06 (14.3%) stddev-sans-first:11.43 14:12:03 INFO - PROCESS | 1665 | Values: 84.0 71.0 92.0 69.0 67.0 69.0 93.0 68.0 68.0 89.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:89.00 stddev:1.87 (2.1%) stddev-sans-first:1.94 14:12:03 INFO - PROCESS | 1665 | Values: 89.0 86.0 90.0 86.0 90.0 85.0 89.0 88.0 89.0 86.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 14:12:03 INFO - PROCESS | 1665 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 96.0 94.0 94.0 94.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:82.00 Median:82.50 stddev:2.00 (2.4%) stddev-sans-first:2.09 14:12:03 INFO - PROCESS | 1665 | Values: 81.0 84.0 80.0 79.0 83.0 80.0 82.0 85.0 84.0 82.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.50 14:12:03 INFO - PROCESS | 1665 | Values: 58.0 57.0 55.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:5.72 (8.0%) stddev-sans-first:5.63 14:12:03 INFO - PROCESS | 1665 | Values: 65.0 67.0 72.0 77.0 72.0 68.0 68.0 70.0 67.0 84.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:2.26 (2.5%) stddev-sans-first:2.32 14:12:03 INFO - PROCESS | 1665 | Values: 90.0 92.0 88.0 86.0 90.0 86.0 91.0 86.0 87.0 87.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:150.50 stddev:13.13 (8.7%) stddev-sans-first:13.71 14:12:03 INFO - PROCESS | 1665 | Values: 148.0 149.0 148.0 148.0 157.0 152.0 173.0 142.0 183.0 146.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.00 stddev:4.09 (2.4%) stddev-sans-first:4.34 14:12:03 INFO - PROCESS | 1665 | Values: 174.0 174.0 171.0 176.0 177.0 166.0 173.0 174.0 174.0 182.0 14:12:03 INFO - PROCESS | 1665 | 14:12:03 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 14:12:03 INFO - PROCESS | 1665 | Values: 69.0 69.0 68.0 70.0 69.0 68.0 69.0 69.0 66.0 69.0 14:12:03 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:12:03 INFO - PROCESS | 1665 | 14:12:04 INFO - TEST-INFO | 1665: exit 0 14:12:04 INFO - TEST-OK | kraken | took 59046ms 14:12:04 INFO - SUITE-END | took 1178s 14:12:04 INFO - Completed test suite (00:19:38) 14:12:04 INFO - javascript benchmark 14:12:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.4917613181888, 3333.616634087079, 3371.443711787555, 3381.0702056934356, 3384.120128766521, 5571.693556854371, 5672.602917795756, 5723.9713801431035, 5758.5393168546525, 5761.107028410593, 5659.801906933259, 5668.744906479208, 5740.052891272935, 5778.335491418488, 5816.302043754756, 4269.487661480626, 5158.9742051289695, 5168.483151684839, 5194.896102077956, 5199.0, 5178.715170665612, 5257.053730328539, 5289.074411977907, 5307.0, 5315.441878602749, 5116.872078198037, 5269.499397557226, 5270.0, 5295.920561191585, 5362.8123015694455, 5122.33409656746, 5188.351456067991, 5197.350331208599, 5199.454057324002, 5205.609579281569, 4310.504292006397, 5077.162268225738, 5143.511366420222, 5157.974210128926, 5174.689518628894, 5677.943220567783, 5737.913931291034, 5742.454466825645, 5747.023006088975, 5750.913736293917, 6117.969410152965, 6208.720607572625, 6213.782517611907, 6214.161088253073, 6227.314995350508, 6238.251409830804, 6307.211598550181, 6321.0, 6326.335734747831, 6344.49244060474, 5816.389279125673, 5821.7380217890295, 5832.795852145239, 5838.795642152504, 5840.269966254218, 6236.688165591702, 6271.184745982993, 6276.780312689034, 6294.748210071546, 6303.243610766645, 6082.753035627686, 6088.948840530829, 6119.106526814625, 6145.692715364214, 6153.4154255345675, 6294.9685251574365, 6298.08677741734, 6303.684815759194, 6317.14718513004, 6335.873282534416, 6223.96888015557, 6243.531735119885, 6264.404881536247, 6268.529860260499, 6270.247570291503, 6100.157317757059, 6165.599236049642, 6169.537284703665, 6175.135481032659, 6293.087502312231, 4868.269759536027, 4884.535969082932, 4935.703857768545, 4941.728204948762, 4955.157623204064, 4408.31671090975, 4413.3821265022925, 4422.115576884636, 4452.1763473757455, 4452.666050046195, 5836.737346819404, 5845.09401042839, 5864.120381942743, 5866.384029676908, 5902.970485147547, 6164.753409863645, 6186.783462578788, 6235.095911092866, 6243.7814676486105, 6336.334684858116, 5812.796552120655, 5858.326292476335, 5866.6186697864505, 5905.527557795366, 5910.763569457259, 5379.596530260246, 5391.78432862689, 5395.81114660985, 5397.73011349431, 5398.028354896078, 6195.597286176384, 6204.3795620437595, 6206.813795585959, 6270.4670103039925, 6292.968535157478, 6212.502999760099, 6240.906386404298, 6269.686515674107, 6295.307516173126, 6309.4952403806665, 6293.968530157503, 6296.150019747275, 6305.1172835803945, 6309.968450157719, 6318.052292156213, 6177.81466556004, 6192.102145189013, 6196.659183744757, 6214.564980451506, 6230.06549017651, 6140.907886381798, 6150.231221097363, 6204.286507051746, 6226.564140510302, 6312.968435157794, 6158.414950579688, 6182.505399568114, 6201.379862013762, 6204.13142160089, 6205.565610407409, 5902.734376952962, 6138.987067133873, 6140.846478838065, 6143.631382117087, 6154.907676384947, 5820.476157145878, 5895.882082358415, 5967.940320596738, 6019.006863867413, 6054.697265136638, 6087.0, 6149.554854609252, 6156.07658851158, 6156.938430615636, 6162.537809664203, 5794.797182098607, 5864.618799778001, 6007.098935159761, 6024.457798798129, 6056.0], "value": 5710.135579708663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.7163701778933, 515.060015471764, 527.6886636884238, 531.0865311663937, 540.4595404595404, 26099.34751631208, 31093.99999999997, 31141.0, 31158.532622010658, 38314.233715325674, 38288.23423531534, 40365.0, 40470.190596188135, 40546.78359649208, 40644.0, 9487.620495180185, 9675.516224188797, 9681.903180968206, 9687.709368718915, 9703.126718595326, 8441.620127094295, 8541.658333666677, 8766.6931657392, 9363.625454981793, 11276.54893804251, 11447.885521144764, 11579.594714185005, 11582.6525204244, 11593.594224202154, 11652.475638596241, 11488.942555287254, 11532.308061516253, 11544.76910461786, 11559.711007224803, 11569.595064172714, 7453.180150183475, 7609.7336593219525, 8726.0, 8792.34057445694, 11343.602973895873, 31163.376732465225, 38326.42510362347, 39006.02484937871, 39055.0, 40180.79909600462, 2922.7077292270815, 3293.766330720418, 3469.9479507807405, 3507.5966263879727, 4056.9797151014054, 24812.50374992508, 29198.0, 29667.70332296671, 30831.84584077088, 30895.845520772476, 3057.8929737459084, 3182.6499085100622, 3193.9840300798346, 3232.628247751515, 3236.1585987643384, 478599.6070019662, 481879.0, 486483.0, 493506.0, 497766.0, 58321.708391457774, 60494.697526512085, 60648.696756516816, 60748.69625651932, 60836.087458688155, 63401.731965360435, 63519.0, 63571.0, 63707.681461592394, 63718.36281637217, 15728.05631662104, 15904.602384940468, 15911.363545458284, 15914.840851591336, 15947.60130996711, 12253.877461225451, 12299.93850030744, 12305.50777968889, 12313.630591082281, 12346.75306493883, 15186.772198417033, 16260.430884918971, 16395.672086558203, 16652.50042498727, 16721.83278167227, 7203.8559228816175, 7644.96792932958, 7937.404694647925, 8053.7114061749835, 8058.0, 929.4376901974343, 962.8074385123003, 975.987914447003, 994.2841154368842, 999.5152351109706, 28777.95662910812, 29371.853140734587, 29543.852280738458, 30235.848820755757, 31201.21996950049, 1030.907218350352, 1039.4127318065268, 1052.5368837711383, 1060.3372891942536, 1108.8336749487642, 14529.78205326921, 15237.542873713806, 15365.539033829004, 15530.767038494432, 15641.061536307858, 643448.0, 648522.0, 648954.0, 649978.0, 650378.0, 49118.280860169725, 49896.750516247914, 55438.72280638652, 56623.43376566264, 56749.71625141848, 1323.2060763541797, 1354.850966393696, 1364.5496985994598, 1366.2349084512507, 1370.3216907630785, 30084.398312034074, 30380.544291836082, 31053.8447307762, 31715.048548543582, 32624.0, 54752.726236368566, 55317.44682553123, 55421.0, 55578.0, 55681.60795980133, 601064.0, 603899.0, 605125.8718532072, 606279.0, 606403.0, 26132.477350453264, 26722.465550689267, 26824.0, 41375.37936931009, 42001.78999104985, 45497.31754023626, 46754.53245467502, 46838.0, 46980.59058228259, 47482.0, 38237.426438604, 38258.0, 38603.411196892106, 39423.0, 39541.60458395494, 35496.29007419785, 38039.80980095082, 38299.0, 38976.41535377028, 39529.61646342364, 37145.628543714214, 37251.25497490089, 37440.6255937448, 37920.24159516739, 38057.80971095237, 30941.381172375975, 32762.0, 33401.49897751584, 34411.13972150616, 34437.827810860785, 22926.42683932915, 23419.765802341757, 24960.37599060038, 24965.50068998646, 25730.0], "value": 19925.207260860767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.5204583468557, 346.0242117229411, 356.1914454188991, 367.28379659663653, 371.8624109079639, 13292.46830126795, 15132.924335378308, 16207.027578345307, 17409.0, 20457.283995060177, 17522.82477175228, 20628.69056964143, 20657.38027859163, 20987.685184722202, 21193.894030529864, 5772.365039845603, 6050.788222412217, 6164.044573091178, 6172.22847144107, 6173.506119510451, 4753.762311884409, 6083.634981901078, 6778.389944904958, 6864.828379290508, 6928.411085057776, 5429.891402171954, 6856.0, 6857.931420685804, 6861.27956564561, 6863.553868998524, 5932.11018347247, 6054.909176362358, 6078.966575682145, 6087.056506241495, 6089.969550152266, 5794.0, 5836.095405212199, 5884.735186916599, 5901.940980590182, 5963.224780778514, 13472.461101555926, 13708.52020179299, 13712.65718357039, 18886.52783680419, 25703.10039148621, 1788.847947924428, 2111.9155233790784, 2688.7714544263763, 2759.7930155238237, 2893.204368798576, 10257.692269231935, 12346.074044446703, 12686.0, 15817.841821581753, 15821.208939552977, 1779.80422153563, 1813.3925135079764, 1819.2120724106046, 1831.9740945070669, 1940.0590713503939, 115234.0, 124049.75950240472, 125500.0, 125522.37238813748, 126522.36738816339, 10977.780444391226, 11346.773064538664, 11378.0, 11520.366379849189, 11889.405529723479, 12791.296478693575, 14504.782428263585, 14509.637259068397, 14512.346944387316, 14526.709465810836, 7275.563466192046, 8190.140035296327, 8464.44981076228, 8599.828003439896, 8611.397202195787, 6725.831854203684, 8008.676399294228, 8029.7189598363775, 8428.873566896502, 8459.661613535513, 4476.9104617908115, 4477.417935668343, 4486.237339652267, 4489.528599497071, 4589.65577581676, 1668.8568330693513, 1864.7016477363827, 1903.1340739963284, 1918.856085793571, 1929.2861641192849, 870.9695160669346, 902.354816306331, 964.3346091197052, 1011.0193112680688, 1043.436544266103, 18703.81296187048, 18952.52618684544, 19757.604847902963, 20121.899390502953, 21619.895731996497, 925.4817302310728, 942.0767647705287, 949.7293271417612, 970.3256236915418, 983.9409635421897, 10546.314489558154, 10929.672109836718, 11143.609973651046, 11159.888401116048, 11176.385298808482, 470244.0, 477534.0, 479061.0, 591409.0, 597947.0, 127272.0, 145443.0, 146615.26692366684, 148623.0, 151704.2414787919, 858.3690987124459, 874.0560194989523, 930.464982634974, 986.8223719730374, 989.5942663507927, 15682.451114211404, 18804.0, 19637.50906227356, 19684.0, 19752.604947901247, 54547.454525455825, 55093.62265943223, 56414.71792641011, 56833.71583142058, 57097.85804283974, 74687.2531274702, 77679.0, 78778.0, 80127.59936200282, 80805.0, 11971.14447260676, 11980.58067967617, 12172.634820955385, 12695.111342205957, 12784.424700888296, 13129.540466083641, 13296.268705220918, 13470.528531501743, 14044.929775351058, 14319.35562899693, 11627.0, 11764.941175294069, 11837.585684501, 12106.213096148722, 12181.512739490321, 11704.473298701409, 11745.001674857733, 11905.464254108412, 12069.456874440846, 12264.202826816228, 10920.563177472812, 11400.828987565359, 11844.23012504219, 12118.515259389525, 12227.938860305641, 12486.313252770822, 12510.249385036926, 12786.232826030468, 12821.487140514275, 12877.935610321889, 11616.186866919235, 11743.706407339885, 11995.82006269924, 12055.879441205827, 12202.633920982385], "value": 9848.496841182936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.8978576606758, 1504.2779465856393, 1558.3221298735052, 1768.893866368018, 1936.6804477261253, 7062.964685176574, 7761.534307941528, 8734.563271836414, 8750.474971501715, 8877.55612219388, 8643.0924752901, 8689.0, 8713.215810577047, 8716.60775265113, 8726.345524085687, 2304.158981971581, 2333.3116730564525, 2334.3580515358244, 2335.2994101769486, 2337.91817286395, 2312.4450131968374, 2356.446235134742, 2369.9052037918464, 2370.3481542575755, 2372.1697405907967, 2291.713535808024, 2304.7234331880113, 2330.33585428153, 2334.9066037358484, 2343.7773411525877, 2271.46620544172, 2279.179495381661, 2294.804941579959, 2309.2148669452467, 2315.2128276385943, 2309.3187509684685, 2327.476317828492, 2334.9066037358657, 2337.7662233776655, 2337.836351455399, 8633.481991080555, 8705.521196334199, 8751.212390884852, 8770.210681038674, 8775.561221938877, 4619.19164146273, 5189.766460509286, 5199.090159222121, 5386.946130538684, 5396.838094857121, 3355.983220083884, 3528.0, 3530.3998320285614, 3599.3881040223223, 3607.549056367954, 949.5015117063527, 986.3046552180696, 1018.6485662446444, 1022.044388496758, 1029.12524354299, 11366.204365694404, 11398.715032124263, 11473.942630286962, 11491.597794077166, 11496.425178741114, 4311.6335111515245, 4442.911141777211, 4522.23122069249, 4525.954740452619, 4528.705634133771, 9000.549972501349, 9007.414518056305, 9018.368714189945, 9026.86459703105, 9032.0, 5168.767405466763, 5241.397239317451, 5244.265802787613, 5245.790168393221, 5251.264822924793, 4421.40311058003, 4537.3647689323525, 4757.167495688241, 4911.705297682151, 4957.504249575086, 3595.280943811248, 3622.8550857965915, 3713.9814300928324, 3728.422094575345, 3763.1156678180605, 1127.3799410324452, 1135.5401062569672, 1136.2046567402685, 1146.529922731676, 1151.3552410649895, 750.3696894608555, 819.2872201185007, 884.8230353929112, 922.6632279218171, 975.0395860077817, 5711.771529138871, 5722.4277572242445, 5744.454276843693, 5881.705914704247, 6088.512918966472, 880.264978742757, 909.4857062990179, 927.2674587076134, 951.1962391778935, 1021.6781713760141, 3347.911928623207, 3909.8045097745567, 3915.5888631693833, 4008.939865902014, 4035.757854528738, 10327.586896524055, 10726.088282495919, 10733.08768754649, 10736.624218152327, 10754.193435492212, 10524.579016839394, 10695.465226738632, 10696.946515267375, 10705.9464702676, 10718.732031699114, 7743.5353878767455, 8089.069756977905, 8162.591870406574, 8166.632501537445, 8242.381821363302, 5700.372958974426, 5808.738606762621, 5812.273465816773, 5931.0, 5973.522118230618, 9814.509274536102, 9948.950255248677, 9987.900120998696, 10007.649732259337, 10020.0, 9777.511124443607, 9921.503924803876, 10085.092341689284, 10190.286679932333, 10205.489725513844, 6720.126383570105, 6920.134983127109, 6932.549384290005, 7146.678399471933, 7357.889631655423, 7854.136045035156, 7923.920760792318, 7938.404619653434, 7941.8411631768195, 8153.714619988272, 6453.903191452038, 7208.603526805866, 7383.741569045058, 7394.55632662042, 7503.324700776956, 7264.600446975467, 7291.598962057138, 7292.781216563511, 7298.051253337032, 7331.450141239322, 6799.524033317621, 6905.378515933389, 6930.792076237721, 6942.375186233263, 6955.652217389212, 4317.352397140454, 4914.663568939315, 5004.524570165829, 5042.84871453857, 5137.5889928806355, 4943.826966056171, 4970.826021089245, 5043.9747801260755, 5133.973205359018, 5209.6874187548865], "value": 4487.250217928012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.38069675777496, 292.1483874505814, 293.64762285257683, 314.59731543624156, 317.1389677026872, 5376.489233522814, 5398.6490878092945, 5415.783368665248, 5435.266239057726, 5481.5340696040785, 4677.462091859437, 5167.819126330579, 5202.8699282517955, 5234.18870075138, 5317.229001794737, 4051.615096565836, 4054.4526488923984, 4062.7156099073077, 4087.5912408759036, 4091.5703851095654, 3454.4990976308422, 4091.4272001919753, 4113.218488487193, 4134.937975930364, 4138.793060346986, 3373.510840928076, 3734.701223902095, 3920.8823735287842, 4037.555868854424, 4066.4916885389325, 3960.386140148282, 3973.7417067890497, 3991.820368083443, 4002.0995276062945, 4025.2754504189234, 3061.7397521210723, 3206.2144774530157, 3467.8959631211105, 3489.028698785178, 3493.336266109431, 4872.926906096412, 5208.869778255536, 5216.765245563959, 5264.210368444764, 5272.868178295574, 3975.052224410047, 4454.777261136963, 4565.338025986247, 4609.446866376023, 4624.630029597624, 5526.696031718254, 5556.388797232301, 5600.859978500529, 5601.515598366436, 5606.803761868356, 3821.464994900716, 3821.541415030214, 3822.808859557039, 3824.9235015299814, 3857.1321452673205, 5072.974635126838, 5421.8885128548945, 5537.556995440355, 5723.796338409742, 5911.379305172938, 3732.3468393031653, 3779.074126838942, 3857.556381016163, 3876.8449262029767, 3887.8250478728523, 3383.8815641452925, 3499.61504234534, 3745.501799280255, 3861.3049651062515, 3929.1945151243926, 4262.552431994658, 4417.646588272931, 4453.643708503312, 4578.9542104579195, 4602.987342784582, 5108.846734597968, 5533.501984821385, 5564.188530856376, 5614.747336369873, 5817.912731309034, 1310.8689131086815, 1332.2605953695793, 1334.5929491505185, 1339.5311640925793, 1340.3633274194874, 686.1526015371013, 761.46316846623, 781.4334607409696, 820.3970081989733, 827.5283088639538, 4417.779111044435, 4426.543268485957, 4458.592360125561, 4461.620762235247, 4520.615747661485, 4423.933640995388, 4504.774761261924, 4843.927341089887, 4876.0, 4899.485554016777, 4360.738355698668, 4424.646028317791, 4430.82276708928, 4462.44219472566, 4473.642108631302, 2361.6575596538405, 2532.341316437736, 2538.619207118947, 2558.8336758110663, 2576.9871150644126, 4197.845592462098, 4692.741899195509, 4713.434387873477, 4714.339992401066, 4964.404271487372, 4557.453105627346, 4702.576768090888, 4776.928346074812, 4877.170880950176, 4913.803447862117, 4367.410399596014, 4387.42963414754, 4707.270373092108, 4861.034768791034, 5004.9729859407, 4253.532111467674, 4489.595936365743, 4580.381648477412, 4595.299739096556, 4856.368672072608, 4327.0, 4340.544242854455, 4489.169503641837, 4648.373069425674, 4797.016611594685, 4378.80295386702, 5467.808626698046, 6044.576879618385, 6061.6666083365835, 6069.393060693896, 3083.6762139975876, 3823.8279277432025, 3844.000559854514, 3876.4185372194397, 3893.4743809585343, 5888.234529511136, 5893.882122357614, 5904.940950590439, 5910.911336329872, 5914.556408269483, 5353.411124776194, 5621.74702138413, 5666.546676265806, 5668.461496157858, 5679.943200567942, 5437.619366644297, 5663.895540369588, 5670.886582268249, 5673.858153546194, 5677.687727175045, 4651.930221046619, 5242.449542798104, 5400.891982160413, 5508.173773933942, 5610.607257491936, 4978.950210497848, 5656.660600363992, 5661.084541461233, 5670.262865827416, 5671.262735844314, 5539.667619942817, 5568.721563921868, 5572.247746554163, 5576.944230557642, 5594.9720251398485], "value": 3910.828555845772, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5956294256687, 728.9453291003176, 745.3850573277044, 790.7746292306693, 806.0971711682917, 15063.472778452757, 15411.0, 15423.383064677413, 15424.383024678998, 15456.768148477782, 11513.0, 12558.99528037757, 13874.959378046662, 13916.443342266322, 14285.428582856674, 696.4880812602759, 718.4073139659776, 721.9784005632024, 816.8529664660359, 875.9080296568864, 869.3653632848025, 881.180502133016, 885.4864178776327, 886.5567216391804, 889.1064480197425, 912.6668765900465, 914.4147745442922, 928.2573940847329, 949.5062567464914, 951.0584521323874, 735.4961851131992, 758.6965213914423, 940.8870935487716, 941.7033634405175, 942.5146049784366, 677.2516369411778, 694.7221111555418, 699.4928676709396, 700.2367419512705, 701.1270967645263, 14439.061461005002, 14465.20441375724, 14469.0, 14494.130352178798, 14498.492552760708, 13017.414216360286, 13125.86874131256, 13227.404766785517, 13237.007224458108, 13374.398152083082, 11898.940505297418, 11956.402179891058, 12057.0, 12079.879201207963, 12132.211406258564, 3586.8923932282073, 3709.4621279914263, 4247.8300867965245, 4316.007318316773, 4452.710573812692, 74524.88212676815, 76119.0, 88169.0, 91394.0, 91733.54133229358, 7690.692372305157, 10354.585816567404, 10420.374777513374, 10456.0, 11417.48621312043, 20029.899850500653, 20284.290049848183, 20306.49233769138, 20312.76559578445, 20417.69373459399, 7551.471397002267, 7562.735304264324, 7626.656800443993, 7673.808154796063, 7711.730089446843, 4149.431488919527, 4255.8084886180195, 4271.23117838792, 4287.0, 4368.8907777305185, 3346.748993825473, 3440.6559344065395, 3447.052060683332, 3729.720270979633, 3940.645341919241, 611.703323887914, 700.8037749430167, 708.3766285668579, 709.1454796969639, 714.4712912444858, 634.6572850660684, 642.9389208025231, 678.7352932356386, 679.6941376380549, 681.8125015620744, 8666.393352465393, 9101.453912765255, 9145.176934075966, 9213.262938965001, 9305.441673499612, 550.9173623956358, 581.4853854338941, 589.381149792716, 603.6589327030214, 640.4044238857907, 4614.215583350839, 4629.77311012582, 4730.905381892343, 4843.346148270009, 4926.359573255454, 111972.44013780043, 117823.03946565872, 117945.0, 118168.0, 119921.40039299747, 103917.8927266275, 103949.0, 105297.0, 105707.0, 106022.0, 42123.0, 56923.16153127031, 63063.0, 77811.61094194493, 86214.56892715496, 9663.000852090314, 9673.181879018508, 9729.805403891742, 9735.1725103367, 9754.31719779637, 48863.5113648859, 49432.0, 51901.7404912973, 53830.73084634552, 54358.0, 57888.710556446946, 63240.36759632345, 66860.33139668735, 71739.64130179524, 72996.0, 12198.51205951752, 12352.035511477001, 12412.317322547347, 12640.74718505643, 13171.209727416386, 13613.183209007491, 14011.859881401055, 14322.14067155974, 14474.0, 14625.0, 12703.491860325854, 12994.480220791062, 13480.258585777485, 13532.0, 13572.93213533926, 12805.487780488676, 13125.934370328087, 13248.536301229797, 13720.588382348546, 13820.23988680592, 13006.674833129247, 13095.41070651842, 13128.146670466389, 13387.665308367368, 13456.798148027592, 8489.87265191035, 10567.471626418495, 10729.141668666643, 10902.781944361226, 11226.101911846868, 10565.0, 11021.260270150267, 11178.832317515082, 11193.608223712132, 11216.270942388719], "value": 7364.714651939195, "unit": "score"}], "name": "dromaeo_css", "value": 7246.788090904512, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 112.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 112.0, 150.0, 113.0, 111.0, 114.0, 112.0, 145.0, 116.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 183.0, 185.0, 184.0, 184.0, 179.0, 183.0, 183.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 76.0, 113.0, 87.0, 65.0, 58.0, 59.0, 84.0, 57.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 92.0, 69.0, 67.0, 69.0, 93.0, 68.0, 68.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 86.0, 90.0, 85.0, 89.0, 88.0, 89.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 96.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 80.0, 79.0, 83.0, 80.0, 82.0, 85.0, 84.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 72.0, 77.0, 72.0, 68.0, 68.0, 70.0, 67.0, 84.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 88.0, 86.0, 90.0, 86.0, 91.0, 86.0, 87.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 157.0, 152.0, 173.0, 142.0, 183.0, 146.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 171.0, 176.0, 177.0, 166.0, 173.0, 174.0, 174.0, 182.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 70.0, 69.0, 68.0, 69.0, 69.0, 66.0, 69.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1447.0999999999997, "alertThreshold": 2.0}]} 14:12:04 INFO - Return code: 0 14:12:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:04 INFO - # TBPL SUCCESS # 14:12:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:04 INFO - 2016-10-26 14:12:04.520 screenresolution[1672:10574] starting screenresolution argv=screenresolution get 14:12:04 INFO - 2016-10-26 14:12:04.523 screenresolution[1672:10574] Display 0: 1600x1200x32@60 14:12:04 INFO - 2016-10-26 14:12:04.530 screenresolution[1673:10576] starting screenresolution argv=screenresolution list 14:12:04 INFO - Available Modes on Display 0 14:12:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:04 INFO - Intel Iris: 14:12:04 INFO - Chipset Model: Intel Iris 14:12:04 INFO - Type: GPU 14:12:04 INFO - Bus: Built-In 14:12:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:04 INFO - Vendor: Intel (0x8086) 14:12:04 INFO - Device ID: 0x0a2e 14:12:04 INFO - Revision ID: 0x0009 14:12:04 INFO - Displays: 14:12:04 INFO - Display: 14:12:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:04 INFO - Display Serial Number: 1600x1200 60 14:12:04 INFO - Main Display: Yes 14:12:04 INFO - Mirror: Off 14:12:04 INFO - Online: Yes 14:12:04 INFO - Rotation: Supported 14:12:04 INFO - Return code: 0 14:12:04 INFO - Running post-action listener: _resource_record_post_action 14:12:04 INFO - [mozharness: 2016-10-26 21:12:04.770339Z] Finished run-tests step (success) 14:12:04 INFO - Running post-run listener: _resource_record_post_run 14:12:04 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 32304128; Write bytes: 711523840; Read time: 199; Write time: 2003 14:12:04 INFO - TinderboxPrint: CPU usage
53.8% 14:12:04 INFO - TinderboxPrint: I/O read bytes / time
32,304,128 / 199 14:12:04 INFO - TinderboxPrint: I/O write bytes / time
711,523,840 / 2,003 14:12:04 INFO - TinderboxPrint: CPU idle
2,242.9 (46.2%) 14:12:04 INFO - TinderboxPrint: CPU system
972.7 (20.0%) 14:12:04 INFO - TinderboxPrint: CPU user
1,638.1 (33.7%) 14:12:04 INFO - TinderboxPrint: Swap in / out
435,220,480 / 0 14:12:04 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397457920; Write bytes: 392229376; Read time: 29400; Write time: 841 14:12:04 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30342144; Write bytes: 300936192; Read time: 183; Write time: 1110 14:12:05 INFO - Running post-run listener: _upload_blobber_files 14:12:05 INFO - Blob upload gear active. 14:12:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:05 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 14:12:05 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:12:05 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:12:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:06 INFO - (blobuploader) - INFO - Done attempting. 14:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:07 INFO - (blobuploader) - INFO - Done attempting. 14:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:10 INFO - (blobuploader) - INFO - Done attempting. 14:12:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:10 INFO - Return code: 0 14:12:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ac44c27ecb79c4a2e7975069f0e7d59afc9c7108085d7206ea55d14b30795c3fc1ab673fdff8139db608ed58c5ed8fa4813fd1f167acc6645cf23918de3835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cfd012fe6f78fa3159a7b8ca9e5938b781e25bff184ee4006f50ca52cab89f1917fd8ce8456cfc3aa9e099d5d4e41ef3d459cd826b105d2c3ac3ea643d4d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70275737a8a5b17be0d531609024faf7c71490e431f162d315a8080fa46500c63fe65f7ea1ebb8bb08df6d425099b6d101c07027fbc1aa8cf147dd17d77d9365"} 14:12:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:10 INFO - Contents: 14:12:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ac44c27ecb79c4a2e7975069f0e7d59afc9c7108085d7206ea55d14b30795c3fc1ab673fdff8139db608ed58c5ed8fa4813fd1f167acc6645cf23918de3835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cfd012fe6f78fa3159a7b8ca9e5938b781e25bff184ee4006f50ca52cab89f1917fd8ce8456cfc3aa9e099d5d4e41ef3d459cd826b105d2c3ac3ea643d4d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70275737a8a5b17be0d531609024faf7c71490e431f162d315a8080fa46500c63fe65f7ea1ebb8bb08df6d425099b6d101c07027fbc1aa8cf147dd17d77d9365"} 14:12:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:10 INFO - Copying logs to upload dir... 14:12:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.925369 ========= master_lag: 1.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-26 14:12:11.702430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.705517) ========= 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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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/Firefox/sha512/30ac44c27ecb79c4a2e7975069f0e7d59afc9c7108085d7206ea55d14b30795c3fc1ab673fdff8139db608ed58c5ed8fa4813fd1f167acc6645cf23918de3835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cfd012fe6f78fa3159a7b8ca9e5938b781e25bff184ee4006f50ca52cab89f1917fd8ce8456cfc3aa9e099d5d4e41ef3d459cd826b105d2c3ac3ea643d4d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70275737a8a5b17be0d531609024faf7c71490e431f162d315a8080fa46500c63fe65f7ea1ebb8bb08df6d425099b6d101c07027fbc1aa8cf147dd17d77d9365"} build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30ac44c27ecb79c4a2e7975069f0e7d59afc9c7108085d7206ea55d14b30795c3fc1ab673fdff8139db608ed58c5ed8fa4813fd1f167acc6645cf23918de3835", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9cfd012fe6f78fa3159a7b8ca9e5938b781e25bff184ee4006f50ca52cab89f1917fd8ce8456cfc3aa9e099d5d4e41ef3d459cd826b105d2c3ac3ea643d4d99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70275737a8a5b17be0d531609024faf7c71490e431f162d315a8080fa46500c63fe65f7ea1ebb8bb08df6d425099b6d101c07027fbc1aa8cf147dd17d77d9365"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.779635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.779959) ========= 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.yD3MSD4vLm/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.eIn2pjRQ2G/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.005149 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:11.830607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:11.830979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:11.831362) ========= ========= Total master_lag: 1.38 =========