builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0249 starttime: 1476969542.95 results: success (0) buildid: 20161020030211 builduid: b7295da6e1864c90a1b8575f11ec32e9 revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:02.952900) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:02.953361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:02.953645) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:02.984118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 06:19:02.984561) ========= 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.jxNOA3itiM/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.P0q7eInzDt/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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-20 06:19:02-- 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% 157M=0s 2016-10-20 06:19:03 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089900 ========= master_lag: 1.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 06:19:04.291129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:04.291495) ========= 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.jxNOA3itiM/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.P0q7eInzDt/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.025122 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:04.442929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 06:19:04.443299) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 99a239e1866a57f987b08dad796528e4ea30e622 --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 99a239e1866a57f987b08dad796528e4ea30e622 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jxNOA3itiM/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.P0q7eInzDt/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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-20 06:19:04,526 truncating revision to first 12 chars 2016-10-20 06:19:04,526 Setting DEBUG logging. 2016-10-20 06:19:04,526 attempt 1/10 2016-10-20 06:19:04,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/99a239e1866a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 06:19:06,172 unpacking tar archive at: mozilla-central-99a239e1866a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.898575 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 06:19:06.900971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:06.901304) ========= script_repo_revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:06.901707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:06.901971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:19:07.020911) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-20 06:19:07.021285) ========= /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.jxNOA3itiM/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.P0q7eInzDt/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:07 INFO - MultiFileLogger online at 20161020 06:19:07 in /builds/slave/test 06:19:07 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 06:19:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:19:07 INFO - {'append_to_log': False, 06:19:07 INFO - 'base_work_dir': '/builds/slave/test', 06:19:07 INFO - 'blob_upload_branch': 'Firefox', 06:19:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:19:07 INFO - 'branch': 'Firefox', 06:19:07 INFO - 'buildbot_json_path': 'buildprops.json', 06:19:07 INFO - 'config_files': ('talos/mac_config.py',), 06:19:07 INFO - 'default_actions': ('clobber', 06:19:07 INFO - 'read-buildbot-config', 06:19:07 INFO - 'download-and-extract', 06:19:07 INFO - 'populate-webroot', 06:19:07 INFO - 'create-virtualenv', 06:19:07 INFO - 'install', 06:19:07 INFO - 'run-tests'), 06:19:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:19:07 INFO - 'download_minidump_stackwalk': True, 06:19:07 INFO - 'download_symbols': 'ondemand', 06:19:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:19:07 INFO - 'tooltool.py': '/tools/tooltool.py', 06:19:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:19:07 INFO - '/tools/misc-python/virtualenv.py')}, 06:19:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:19:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:19:07 INFO - 'installer_path': 'installer.exe', 06:19:07 INFO - 'log_level': 'info', 06:19:07 INFO - 'log_name': 'talos', 06:19:07 INFO - 'log_to_console': True, 06:19:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:19:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:19:07 INFO - 'opt_config_files': (), 06:19:07 INFO - 'pip_index': False, 06:19:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:19:07 INFO - 'cmd': ('bash', 06:19:07 INFO - '-c', 06:19:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:19:07 INFO - 'enabled': True, 06:19:07 INFO - 'halt_on_failure': False, 06:19:07 INFO - 'name': 'check_screen_resolution'},), 06:19:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:19:07 INFO - 'cmd': ('bash', 06:19:07 INFO - '-c', 06:19:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:19:07 INFO - 'enabled': True, 06:19:07 INFO - 'halt_on_failure': False, 06:19:07 INFO - 'name': 'check_screen_resolution'},), 06:19:07 INFO - 'run_cmd_checks_enabled': True, 06:19:07 INFO - 'sps_profile': False, 06:19:07 INFO - 'sps_profile_interval': 0, 06:19:07 INFO - 'suite': 'dromaeojs', 06:19:07 INFO - 'system_bits': '32', 06:19:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:19:07 INFO - 'title': 't-yosemite-r7-0249', 06:19:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:19:07 INFO - 'use_talos_json': True, 06:19:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:19:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:19:07 INFO - 'work_dir': 'build'} 06:19:07 INFO - [mozharness: 2016-10-20 13:19:07.223708Z] Running clobber step. 06:19:07 INFO - Running pre-action listener: _resource_record_pre_action 06:19:07 INFO - Running main action method: clobber 06:19:07 INFO - rmtree: /builds/slave/test/build 06:19:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:19:09 INFO - Running post-action listener: _resource_record_post_action 06:19:09 INFO - [mozharness: 2016-10-20 13:19:09.205990Z] Finished clobber step (success) 06:19:09 INFO - [mozharness: 2016-10-20 13:19:09.206159Z] Running read-buildbot-config step. 06:19:09 INFO - Running pre-action listener: _resource_record_pre_action 06:19:09 INFO - Running main action method: read_buildbot_config 06:19:09 INFO - Using buildbot properties: 06:19:09 INFO - { 06:19:09 INFO - "project": "", 06:19:09 INFO - "product": "firefox", 06:19:09 INFO - "script_repo_revision": "production", 06:19:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:19:09 INFO - "repository": "", 06:19:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:19:09 INFO - "buildid": "20161020030211", 06:19:09 INFO - "stage_platform": "macosx64", 06:19:09 INFO - "basedir": "/builds/slave/test", 06:19:09 INFO - "nightly_build": "True", 06:19:09 INFO - "buildnumber": 54, 06:19:09 INFO - "slavename": "t-yosemite-r7-0249", 06:19:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:19:09 INFO - "platform": "yosemite_r7", 06:19:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:19:09 INFO - "branch": "mozilla-central", 06:19:09 INFO - "repo_path": "mozilla-central", 06:19:09 INFO - "revision": "99a239e1866a57f987b08dad796528e4ea30e622", 06:19:09 INFO - "pgo_build": "False", 06:19:09 INFO - "builduid": "b7295da6e1864c90a1b8575f11ec32e9", 06:19:09 INFO - "slavebuilddir": "test" 06:19:09 INFO - } 06:19:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:19:09 INFO - Running post-action listener: _resource_record_post_action 06:19:09 INFO - [mozharness: 2016-10-20 13:19:09.209688Z] Finished read-buildbot-config step (success) 06:19:09 INFO - [mozharness: 2016-10-20 13:19:09.209821Z] Running download-and-extract step. 06:19:09 INFO - Running pre-action listener: _resource_record_pre_action 06:19:09 INFO - Running main action method: download_and_extract 06:19:09 INFO - mkdir: /builds/slave/test/build/tests 06:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:09 INFO - trying https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:19:09 INFO - Downloading https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/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 06:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/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 06:19:10 INFO - Downloaded 1199 bytes. 06:19:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:19:10 INFO - Using the following test package requirements: 06:19:10 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:19:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:19:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:19:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'jsshell-mac.zip'], 06:19:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:19:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:19:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:19:10 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:19:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:19:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:19:10 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:19:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:19:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:19:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:19:10 INFO - Fetch https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:19:11 INFO - Http code: 200 06:19:11 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 06:19:11 INFO - x-amz-cf-id: H8AyK5lWYnACE3aPmhcc4zRwbZHvRA7YbEvCV1421ZDnFjA1JCMe_Q== 06:19:11 INFO - x-amz-version-id: WDqjzsulmFBSok_eIkBVraM21KLCjdin 06:19:11 INFO - Expected file size: 16504868 06:19:11 INFO - Obtained file size: 16504868 06:19:18 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 06:19:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:19:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:19:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:19:18 INFO - Http code: 200 06:19:18 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 06:19:18 INFO - x-amz-cf-id: vYnBLGhplEXu17SujTR7990o1HIczTwPA6ZhLZtNlZX8uqgkZ2m5Bg== 06:19:18 INFO - x-amz-version-id: WDqjzsulmFBSok_eIkBVraM21KLCjdin 06:19:18 INFO - Expected file size: 16504868 06:19:18 INFO - Obtained file size: 16504868 06:19:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:19:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:19:25 INFO - Fetch https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:19:25 INFO - Http code: 200 06:19:25 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 06:19:25 INFO - x-amz-cf-id: haxZNcgvUr67_8S2Uv_SjGDbouMspE7ci_HR1-lSx9tOJQUzkn8l7g== 06:19:25 INFO - x-amz-version-id: 01bVpSRjTahSit9oB48ZMLgvS_SWkKMt 06:19:26 INFO - Expected file size: 14409028 06:19:26 INFO - Obtained file size: 14409028 06:19:26 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')]} 06:19:26 INFO - trying https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:19:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:19:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/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 06:19:29 INFO - Downloaded 111766171 bytes. 06:19:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:19:29 INFO - mkdir: /builds/slave/test/properties 06:19:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:19:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:19:29 INFO - Contents: 06:19:29 INFO - build_url:https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:19:29 INFO - Running post-action listener: _resource_record_post_action 06:19:29 INFO - Running post-action listener: set_extra_try_arguments 06:19:29 INFO - [mozharness: 2016-10-20 13:19:29.922035Z] Finished download-and-extract step (success) 06:19:29 INFO - [mozharness: 2016-10-20 13:19:29.922154Z] Running populate-webroot step. 06:19:29 INFO - Running pre-action listener: _resource_record_pre_action 06:19:29 INFO - Running main action method: populate_webroot 06:19:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:19:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:19:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:19:29 INFO - '--tppagecycles', 06:19:29 INFO - '7'], 06:19:29 INFO - 'tests': ['tsvgm']}}, 06:19:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:19:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:19:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:19:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:19:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['damp', 'tps']}, 06:19:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'tests': ['damp', 'tps']}, 06:19:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['dromaeo_dom']}, 06:19:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:19:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['basic_compositor_video']}, 06:19:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:19:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['a11yr', 06:19:29 INFO - 'ts_paint', 06:19:29 INFO - 'tpaint', 06:19:29 INFO - 'sessionrestore', 06:19:29 INFO - 'sessionrestore_no_auto_restore', 06:19:29 INFO - 'tabpaint']}, 06:19:29 INFO - 'other-e10s': {'tests': ['a11yr', 06:19:29 INFO - 'ts_paint', 06:19:29 INFO - 'tpaint', 06:19:29 INFO - 'sessionrestore', 06:19:29 INFO - 'sessionrestore_no_auto_restore', 06:19:29 INFO - 'tabpaint']}, 06:19:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:19:29 INFO - 'ts_paint', 06:19:29 INFO - 'tpaint', 06:19:29 INFO - 'sessionrestore', 06:19:29 INFO - 'sessionrestore_no_auto_restore', 06:19:29 INFO - 'tabpaint']}, 06:19:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:19:29 INFO - 'ts_paint', 06:19:29 INFO - 'tpaint', 06:19:29 INFO - 'sessionrestore', 06:19:29 INFO - 'sessionrestore_no_auto_restore', 06:19:29 INFO - 'tabpaint']}, 06:19:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['a11yr', 06:19:29 INFO - 'ts_paint', 06:19:29 INFO - 'tpaint', 06:19:29 INFO - 'sessionrestore', 06:19:29 INFO - 'sessionrestore_no_auto_restore', 06:19:29 INFO - 'tabpaint']}, 06:19:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['a11yr', 06:19:29 INFO - 'ts_paint', 06:19:29 INFO - 'tpaint', 06:19:29 INFO - 'sessionrestore', 06:19:29 INFO - 'sessionrestore_no_auto_restore', 06:19:29 INFO - 'tabpaint']}, 06:19:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['tsvgx', 06:19:29 INFO - 'tsvgr_opacity', 06:19:29 INFO - 'tart', 06:19:29 INFO - 'tscrollx', 06:19:29 INFO - 'cart']}, 06:19:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:19:29 INFO - 'tsvgr_opacity', 06:19:29 INFO - 'tart', 06:19:29 INFO - 'tscrollx', 06:19:29 INFO - 'cart']}, 06:19:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'talos_options': ['--disable-e10s'], 06:19:29 INFO - 'tests': ['tp5o']}, 06:19:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'tests': ['tp5o']}, 06:19:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'talos_options': ['--disable-e10s', 06:19:29 INFO - '--xperf_path', 06:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:29 INFO - 'tests': ['tp5n']}, 06:19:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:29 INFO - 'talos_options': ['--xperf_path', 06:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:29 INFO - 'tests': ['tp5n']}}, 06:19:29 INFO - 'talos.zip': {'path': '', 06:19:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:19:29 INFO - Running post-action listener: _resource_record_post_action 06:19:29 INFO - [mozharness: 2016-10-20 13:19:29.940880Z] Finished populate-webroot step (success) 06:19:29 INFO - [mozharness: 2016-10-20 13:19:29.941014Z] Running create-virtualenv step. 06:19:29 INFO - Running pre-action listener: _resource_record_pre_action 06:19:29 INFO - Running main action method: create_virtualenv 06:19:29 INFO - Creating virtualenv /builds/slave/test/build/venv 06:19:29 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 06:19:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:19:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:19:30 INFO - Using real prefix '/tools/python27' 06:19:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:33 INFO - Installing pip.................done. 06:19:33 INFO - Return code: 0 06:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:19:33 INFO - Reading from file tmpfile_stdout 06:19:33 INFO - Output received: 06:19:33 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) 06:19:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:33 INFO - 'HOME': '/Users/cltbld', 06:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:33 INFO - 'LOGNAME': 'cltbld', 06:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:33 INFO - 'MOZ_NO_REMOTE': '1', 06:19:33 INFO - 'NO_EM_RESTART': '1', 06:19:33 INFO - 'PAGER': '/bin/cat', 06:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:33 INFO - 'PWD': '/builds/slave/test', 06:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:33 INFO - 'SHELL': '/bin/bash', 06:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:33 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:33 INFO - 'USER': 'cltbld', 06:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:33 INFO - 'XPC_FLAGS': '0x0', 06:19:33 INFO - 'XPC_SERVICE_NAME': '0', 06:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:34 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 06:19:34 INFO - Cleaning up... 06:19:34 INFO - Return code: 0 06:19:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:34 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:34 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 06:19:34 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 06:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:34 INFO - 'HOME': '/Users/cltbld', 06:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:34 INFO - 'LOGNAME': 'cltbld', 06:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:34 INFO - 'MOZ_NO_REMOTE': '1', 06:19:34 INFO - 'NO_EM_RESTART': '1', 06:19:34 INFO - 'PAGER': '/bin/cat', 06:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:34 INFO - 'PWD': '/builds/slave/test', 06:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:34 INFO - 'SHELL': '/bin/bash', 06:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:34 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:34 INFO - 'USER': 'cltbld', 06:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:34 INFO - 'XPC_FLAGS': '0x0', 06:19:34 INFO - 'XPC_SERVICE_NAME': '0', 06:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:34 INFO - Downloading/unpacking psutil>=3.1.1 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:19:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:37 INFO - Installing collected packages: psutil 06:19:37 INFO - Running setup.py install for psutil 06:19:37 INFO - building 'psutil._psutil_osx' extension 06:19:37 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 06:19:38 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 06:19:38 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 06:19:38 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 06:19:38 INFO - building 'psutil._psutil_posix' extension 06:19:38 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 06:19:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:19:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:19:38 INFO - ^ 06:19:38 INFO - 1 warning generated. 06:19:38 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 06:19:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:38 INFO - Successfully installed psutil 06:19:38 INFO - Cleaning up... 06:19:39 INFO - Return code: 0 06:19:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:19:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:19:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:39 INFO - 'HOME': '/Users/cltbld', 06:19:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:39 INFO - 'LOGNAME': 'cltbld', 06:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:39 INFO - 'MOZ_NO_REMOTE': '1', 06:19:39 INFO - 'NO_EM_RESTART': '1', 06:19:39 INFO - 'PAGER': '/bin/cat', 06:19:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:39 INFO - 'PWD': '/builds/slave/test', 06:19:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:39 INFO - 'SHELL': '/bin/bash', 06:19:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:39 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:39 INFO - 'USER': 'cltbld', 06:19:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:39 INFO - 'XPC_FLAGS': '0x0', 06:19:39 INFO - 'XPC_SERVICE_NAME': '0', 06:19:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:19:41 INFO - Installing collected packages: mozsystemmonitor 06:19:41 INFO - Running setup.py install for mozsystemmonitor 06:19:42 INFO - Successfully installed mozsystemmonitor 06:19:42 INFO - Cleaning up... 06:19:42 INFO - Return code: 0 06:19:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:19:42 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')]} 06:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:42 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')]} 06:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:42 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:42 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 06:19:42 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 06:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:42 INFO - 'HOME': '/Users/cltbld', 06:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:42 INFO - 'LOGNAME': 'cltbld', 06:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:42 INFO - 'MOZ_NO_REMOTE': '1', 06:19:42 INFO - 'NO_EM_RESTART': '1', 06:19:42 INFO - 'PAGER': '/bin/cat', 06:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:42 INFO - 'PWD': '/builds/slave/test', 06:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:42 INFO - 'SHELL': '/bin/bash', 06:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:42 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:42 INFO - 'USER': 'cltbld', 06:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:42 INFO - 'XPC_FLAGS': '0x0', 06:19:42 INFO - 'XPC_SERVICE_NAME': '0', 06:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:42 INFO - Downloading/unpacking jsonschema==2.5.1 06:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:19:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:45 INFO - Downloading functools32-3.2.3-2.tar.gz 06:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:19:45 INFO - warning: no files found matching '*.txt' 06:19:45 INFO - no previously-included directories found matching 'build' 06:19:45 INFO - no previously-included directories found matching 'dist' 06:19:45 INFO - no previously-included directories found matching '.git*' 06:19:45 INFO - Installing collected packages: jsonschema, functools32 06:19:45 INFO - Running setup.py install for functools32 06:19:45 INFO - warning: no files found matching '*.txt' 06:19:45 INFO - no previously-included directories found matching 'build' 06:19:45 INFO - no previously-included directories found matching 'dist' 06:19:45 INFO - no previously-included directories found matching '.git*' 06:19:45 INFO - Successfully installed jsonschema functools32 06:19:45 INFO - Cleaning up... 06:19:45 INFO - Return code: 0 06:19:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:45 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:45 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 06:19:45 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 06:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:45 INFO - 'HOME': '/Users/cltbld', 06:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:45 INFO - 'LOGNAME': 'cltbld', 06:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:45 INFO - 'MOZ_NO_REMOTE': '1', 06:19:45 INFO - 'NO_EM_RESTART': '1', 06:19:45 INFO - 'PAGER': '/bin/cat', 06:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:45 INFO - 'PWD': '/builds/slave/test', 06:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:45 INFO - 'SHELL': '/bin/bash', 06:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:45 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:45 INFO - 'USER': 'cltbld', 06:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:45 INFO - 'XPC_FLAGS': '0x0', 06:19:45 INFO - 'XPC_SERVICE_NAME': '0', 06:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:19:46 INFO - Cleaning up... 06:19:46 INFO - Return code: 0 06:19:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:19:46 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')]} 06:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:46 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')]} 06:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:46 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:46 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 06:19:46 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 06:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:46 INFO - 'HOME': '/Users/cltbld', 06:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:46 INFO - 'LOGNAME': 'cltbld', 06:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:46 INFO - 'MOZ_NO_REMOTE': '1', 06:19:46 INFO - 'NO_EM_RESTART': '1', 06:19:46 INFO - 'PAGER': '/bin/cat', 06:19:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:46 INFO - 'PWD': '/builds/slave/test', 06:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:46 INFO - 'SHELL': '/bin/bash', 06:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:46 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:46 INFO - 'USER': 'cltbld', 06:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:46 INFO - 'XPC_FLAGS': '0x0', 06:19:46 INFO - 'XPC_SERVICE_NAME': '0', 06:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:19:46 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 06:19:46 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 06:19:46 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 06:19:46 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 06:19:46 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 06:19:46 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 06:19:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:19:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19:49 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 06:19:49 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 06:19:49 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 06:19:49 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 06:19:49 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 06:19:49 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 06:19:49 INFO - Downloading docopt-0.6.1.tar.gz 06:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:50 INFO - Running setup.py install for blobuploader 06:19:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:19:50 INFO - Running setup.py install for requests 06:19:50 INFO - Running setup.py install for docopt 06:19:50 INFO - Successfully installed blobuploader requests docopt 06:19:50 INFO - Cleaning up... 06:19:50 INFO - Return code: 0 06:19:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:50 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:50 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 06:19:50 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 06:19:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:50 INFO - 'HOME': '/Users/cltbld', 06:19:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:50 INFO - 'LOGNAME': 'cltbld', 06:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:50 INFO - 'MOZ_NO_REMOTE': '1', 06:19:50 INFO - 'NO_EM_RESTART': '1', 06:19:50 INFO - 'PAGER': '/bin/cat', 06:19:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:50 INFO - 'PWD': '/builds/slave/test', 06:19:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:50 INFO - 'SHELL': '/bin/bash', 06:19:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:50 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:50 INFO - 'USER': 'cltbld', 06:19:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:50 INFO - 'XPC_FLAGS': '0x0', 06:19:50 INFO - 'XPC_SERVICE_NAME': '0', 06:19:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-H_951T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-XY1CjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-dovGWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-4MmaTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-BWTXz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-qv1yWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-44cS5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-lYC4SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-QByx2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-pQCsxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ADo4Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ZDw6k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Z8L7lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-mqEIHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-tDWnjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Be_hgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-_bOjaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:53 INFO - Running setup.py install for manifestparser 06:19:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:19:53 INFO - Running setup.py install for mozcrash 06:19:53 INFO - Running setup.py install for mozdebug 06:19:53 INFO - Running setup.py install for mozdevice 06:19:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:19:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:19:53 INFO - Running setup.py install for mozfile 06:19:53 INFO - Running setup.py install for mozhttpd 06:19:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:19:53 INFO - Running setup.py install for mozinfo 06:19:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Running setup.py install for mozInstall 06:19:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Running setup.py install for mozleak 06:19:54 INFO - Running setup.py install for mozlog 06:19:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Running setup.py install for moznetwork 06:19:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Running setup.py install for mozprocess 06:19:54 INFO - Running setup.py install for mozprofile 06:19:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:19:54 INFO - Running setup.py install for mozrunner 06:19:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:19:55 INFO - Running setup.py install for mozscreenshot 06:19:55 INFO - Running setup.py install for moztest 06:19:55 INFO - Running setup.py install for mozversion 06:19:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:19:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:55 INFO - Cleaning up... 06:19:55 INFO - Return code: 0 06:19:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:55 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')]} 06:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:55 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')]} 06:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:55 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:19:55 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 06:19:55 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 06:19:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:19:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:19:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:19:55 INFO - 'HOME': '/Users/cltbld', 06:19:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:19:55 INFO - 'LOGNAME': 'cltbld', 06:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:55 INFO - 'MOZ_NO_REMOTE': '1', 06:19:55 INFO - 'NO_EM_RESTART': '1', 06:19:55 INFO - 'PAGER': '/bin/cat', 06:19:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:55 INFO - 'PWD': '/builds/slave/test', 06:19:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:19:55 INFO - 'SHELL': '/bin/bash', 06:19:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:19:55 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:19:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:19:55 INFO - 'USER': 'cltbld', 06:19:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:19:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:55 INFO - 'XPC_FLAGS': '0x0', 06:19:55 INFO - 'XPC_SERVICE_NAME': '0', 06:19:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:55 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-GFO4_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-0Ta8nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-AvmWBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-SHdzfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-mNkJkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-z4uNO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-nowESL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-M9ld4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-_mxw5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-fxg_zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:56 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)) 06:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:56 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jeB2BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:57 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)) 06:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-beclXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:57 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)) 06:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-DDtJM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:57 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)) 06:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-feILp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:57 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)) 06:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-MoR_gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:57 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)) 06:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-2qoIkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:57 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)) 06:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:57 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-UW4Bky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:57 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)) 06:19:57 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)) 06:19:57 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)) 06:19:57 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)) 06:19:57 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)) 06:19:57 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)) 06:19:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:57 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 06:19:57 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 06:19:57 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 06:19:57 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 06:19:57 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 06:19:57 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 06:20:00 INFO - Downloading blessings-1.6.tar.gz 06:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:20:00 INFO - Installing collected packages: blessings 06:20:00 INFO - Running setup.py install for blessings 06:20:00 INFO - Successfully installed blessings 06:20:00 INFO - Cleaning up... 06:20:00 INFO - Return code: 0 06:20:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:00 INFO - Reading from file tmpfile_stdout 06:20:00 INFO - Current package versions: 06:20:00 INFO - blessings == 1.6 06:20:00 INFO - blobuploader == 1.2.4 06:20:00 INFO - docopt == 0.6.1 06:20:00 INFO - functools32 == 3.2.3-2 06:20:00 INFO - jsonschema == 2.5.1 06:20:00 INFO - manifestparser == 1.1 06:20:00 INFO - mozInstall == 1.12 06:20:00 INFO - mozcrash == 0.17 06:20:00 INFO - mozdebug == 0.1 06:20:00 INFO - mozdevice == 0.48 06:20:00 INFO - mozfile == 1.2 06:20:00 INFO - mozhttpd == 0.7 06:20:00 INFO - mozinfo == 0.9 06:20:00 INFO - mozleak == 0.1 06:20:00 INFO - mozlog == 3.4 06:20:00 INFO - moznetwork == 0.27 06:20:00 INFO - mozprocess == 0.23 06:20:00 INFO - mozprofile == 0.28 06:20:00 INFO - mozrunner == 6.12 06:20:00 INFO - mozscreenshot == 0.1 06:20:00 INFO - mozsystemmonitor == 0.3 06:20:00 INFO - moztest == 0.7 06:20:00 INFO - mozversion == 1.4 06:20:00 INFO - psutil == 3.1.1 06:20:00 INFO - requests == 1.2.3 06:20:00 INFO - wsgiref == 0.1.2 06:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:01 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:20:01 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 06:20:01 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 06:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:01 INFO - 'HOME': '/Users/cltbld', 06:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:01 INFO - 'LOGNAME': 'cltbld', 06:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:01 INFO - 'MOZ_NO_REMOTE': '1', 06:20:01 INFO - 'NO_EM_RESTART': '1', 06:20:01 INFO - 'PAGER': '/bin/cat', 06:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:01 INFO - 'PWD': '/builds/slave/test', 06:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:01 INFO - 'SHELL': '/bin/bash', 06:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:20:01 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:01 INFO - 'USER': 'cltbld', 06:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:01 INFO - 'XPC_FLAGS': '0x0', 06:20:01 INFO - 'XPC_SERVICE_NAME': '0', 06:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 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)) 06:20:01 INFO - Cleaning up... 06:20:01 INFO - Return code: 0 06:20:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:02 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 0x1035d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc3488040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, '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.jxNOA3itiM/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.P0q7eInzDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 06:20:02 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 06:20:02 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 06:20:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:20:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:02 INFO - 'HOME': '/Users/cltbld', 06:20:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:02 INFO - 'LOGNAME': 'cltbld', 06:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:02 INFO - 'MOZ_NO_REMOTE': '1', 06:20:02 INFO - 'NO_EM_RESTART': '1', 06:20:02 INFO - 'PAGER': '/bin/cat', 06:20:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:02 INFO - 'PWD': '/builds/slave/test', 06:20:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:02 INFO - 'SHELL': '/bin/bash', 06:20:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:20:02 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:20:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:02 INFO - 'USER': 'cltbld', 06:20:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:02 INFO - 'XPC_FLAGS': '0x0', 06:20:02 INFO - 'XPC_SERVICE_NAME': '0', 06:20:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:20:02 INFO - Cleaning up... 06:20:02 INFO - Return code: 0 06:20:02 INFO - Running post-action listener: _resource_record_post_action 06:20:02 INFO - Running post-action listener: _start_resource_monitoring 06:20:02 INFO - Starting resource monitoring. 06:20:02 INFO - [mozharness: 2016-10-20 13:20:02.612131Z] Finished create-virtualenv step (success) 06:20:02 INFO - [mozharness: 2016-10-20 13:20:02.613176Z] Running install step. 06:20:02 INFO - Running pre-action listener: _resource_record_pre_action 06:20:02 INFO - Running main action method: install 06:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:02 INFO - Reading from file tmpfile_stdout 06:20:02 INFO - Detecting whether we're running mozinstall >=1.0... 06:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:20:02 INFO - Reading from file tmpfile_stdout 06:20:02 INFO - Output received: 06:20:02 INFO - Usage: mozinstall [options] installer 06:20:02 INFO - Options: 06:20:02 INFO - -h, --help show this help message and exit 06:20:02 INFO - -d DEST, --destination=DEST 06:20:02 INFO - Directory to install application into. [default: 06:20:02 INFO - "/builds/slave/test"] 06:20:02 INFO - --app=APP Application being installed. [default: firefox] 06:20:02 INFO - mkdir: /builds/slave/test/build/application 06:20:02 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'] 06:20:02 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 06:20:37 INFO - Reading from file tmpfile_stdout 06:20:37 INFO - Output received: 06:20:37 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:20:37 INFO - Running post-action listener: _resource_record_post_action 06:20:37 INFO - [mozharness: 2016-10-20 13:20:37.172600Z] Finished install step (success) 06:20:37 INFO - [mozharness: 2016-10-20 13:20:37.172770Z] Running run-tests step. 06:20:37 INFO - Running pre-action listener: _resource_record_pre_action 06:20:37 INFO - Running main action method: run_tests 06:20:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:20:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:20:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:20:37 INFO - 2016-10-20 06:20:37.187 screenresolution[1647:7596] starting screenresolution argv=screenresolution get 06:20:37 INFO - 2016-10-20 06:20:37.190 screenresolution[1647:7596] Display 0: 1600x1200x32@60 06:20:37 INFO - 2016-10-20 06:20:37.196 screenresolution[1648:7598] starting screenresolution argv=screenresolution list 06:20:37 INFO - Available Modes on Display 0 06:20:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:20:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:20:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:20:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:20:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:20:37 INFO - Intel Iris: 06:20:37 INFO - Chipset Model: Intel Iris 06:20:37 INFO - Type: GPU 06:20:37 INFO - Bus: Built-In 06:20:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:20:37 INFO - Vendor: Intel (0x8086) 06:20:37 INFO - Device ID: 0x0a2e 06:20:37 INFO - Revision ID: 0x0009 06:20:37 INFO - Displays: 06:20:37 INFO - Display: 06:20:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:20:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:20:37 INFO - Display Serial Number: 1600x1200 60 06:20:37 INFO - Main Display: Yes 06:20:37 INFO - Mirror: Off 06:20:37 INFO - Online: Yes 06:20:37 INFO - Rotation: Supported 06:20:37 INFO - Return code: 0 06:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:20:37 INFO - Python 2.7.3 06:20:37 INFO - Return code: 0 06:20:37 INFO - grabbing minidump binary from tooltool 06:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:20:37 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 0x1033e8d30>, '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 0x10320edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:20:37 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 06:20:37 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 06:20:37 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 06:20:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:20:37 INFO - Return code: 0 06:20:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:20:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:20:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:20:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:20:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:20:37 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 06:20:37 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0249 --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 06:20:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jxNOA3itiM/Render', 06:20:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:20:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:20:37 INFO - 'HOME': '/Users/cltbld', 06:20:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:20:37 INFO - 'LOGNAME': 'cltbld', 06:20:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:20:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:37 INFO - 'MOZ_NO_REMOTE': '1', 06:20:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:20:37 INFO - 'NO_EM_RESTART': '1', 06:20:37 INFO - 'PAGER': '/bin/cat', 06:20:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:37 INFO - 'PWD': '/builds/slave/test', 06:20:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:20:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:20:37 INFO - 'SHELL': '/bin/bash', 06:20:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P0q7eInzDt/Listeners', 06:20:37 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 06:20:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:20:37 INFO - 'USER': 'cltbld', 06:20:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:20:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:37 INFO - 'XPC_FLAGS': '0x0', 06:20:37 INFO - 'XPC_SERVICE_NAME': '0', 06:20:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:20:37 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 06:20:37 INFO - mozversion application_buildid: 20161020030211 06:20:37 INFO - mozversion application_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 06:20:37 INFO - mozversion application_display_name: Nightly 06:20:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:20:37 INFO - mozversion application_name: Firefox 06:20:37 INFO - mozversion application_remotingname: firefox 06:20:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:20:37 INFO - mozversion application_vendor: Mozilla 06:20:37 INFO - mozversion application_version: 52.0a1 06:20:37 INFO - mozversion platform_buildid: 20161020030211 06:20:37 INFO - mozversion platform_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 06:20:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:20:37 INFO - mozversion platform_version: 52.0a1 06:20:37 INFO - using testdate: 1476969637 06:20:37 INFO - actual date: 1476969637 06:20:37 INFO - starting webserver on 'localhost:49276' 06:20:37 INFO - SUITE-START | Running 2 tests 06:20:37 INFO - TEST-START | dromaeo_css 06:20:37 INFO - operating with platform_type : mac_ 06:20:37 INFO - Initialising browser for dromaeo_css test... 06:20:37 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpdyROSu/profile http://localhost:49276/getInfo.html) 06:20:40 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 06:20:40 INFO - PROCESS | 1658 | colorDepth:24 06:20:40 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 06:20:40 INFO - PROCESS | 1658 | __metrics 06:20:40 INFO - PROCESS | 1658 | 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" 06:20:40 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:41 INFO - TEST-INFO | 1658: exit 0 06:20:41 INFO - Browser initialized. 06:20:41 INFO - Running cycle 1/1 for dromaeo_css test... 06:20:41 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpdyROSu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:53 INFO - PROCESS | 1661 | RSS: Main: 231239680 06:20:53 INFO - PROCESS | 1661 | 06:21:44 INFO - PROCESS | 1661 | 1476969704655 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] 06:23:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 06:23:59 INFO - PROCESS | 1661 | RSS: Main: 368672768 06:23:59 INFO - PROCESS | 1661 | 06:27:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 06:27:03 INFO - PROCESS | 1661 | RSS: Main: 367906816 06:27:03 INFO - PROCESS | 1661 | 06:30:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 06:30:06 INFO - PROCESS | 1661 | RSS: Main: 332210176 06:30:06 INFO - PROCESS | 1661 | 06:33:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 06:33:09 INFO - PROCESS | 1661 | RSS: Main: 346177536 06:33:09 INFO - PROCESS | 1661 | 06:36:12 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 06:36:13 INFO - PROCESS | 1661 | RSS: Main: 329383936 06:36:13 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 06:39:16 INFO - PROCESS | 1661 | RSS: Main: 412405760 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | __start_tp_report 06:39:16 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 06:39:16 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 06:39:16 INFO - PROCESS | 1661 | |i|pagename|runs| 06:39:16 INFO - PROCESS | 1661 | |0;dojo.html;2797.454496373207;3327.2347360107183;3327.883524076658;3360.5967283925934;3375.3249350129963;4525.275955847065;5651.773929042838;5662.207290979256;5709.971450142749;5730.4269573042675;5686.118651609007;5704.458076482738;5705.25831641887;5708.257926469553;5718.885622287562;5155.226715992603;5182.2226666000215;5198.636095473299;5230.555402790767;5277.1556550951855;5182.119039763249;5224.399194092671;5229;5287.762050707708;5309.203619457074;5261.342332208474;5301.920471192935;5330.840074797762;5345.625806193568;5359.839204823861;5275.604329675251;5290.92063619046;5292.682439053669;5299.920501192485;5350.892982140335;4972.552470277692;5008.749562521859;5211.661242019257;5216.452272511369;5221.347331583552;5589.888202235932;5626.9437305626825;5671.7164141793155;5732.828015159552;5756.942430575725;5103.387593488768;6113.633182009094;6117.235345581802;6168.87662246757;6172.783952561639;6190.133381326618;6203.728235711714;6245.656488893109;6263.060540918853;6269.185005949197;5597.720113994284;5747.971260143672;5749.741261643236;5777.8555536111935;5848.298204215522;6182.258129024546;6183.165272688129;6191.102290167901;6226.25284965807;6238.875222495525;6041.395860414012;6054.8882522058975;6073.75704971805;6114.419130182626;6132.877342453126;6222.875542489125;6234.9688251559355;6257.2491301044165;6271.78048768291;6278.466330361879;5992.850178745566;6063.9090413643835;6091.664958427329;6108.1143234230785;6127.846803829851;6225.408586184305;6238.344973777779;6244.781432649836;6246.6876656167005;6251.156093927261;4907.092187945242;4907.55831975124;4910.852674419773;4912.8280510182685;4937.530934561211;4341.45731783527;4364.5635436456105;4365.279728844768;4454.977725111354;4465.754383508938;5699.544036477072;5728.684922329228;5732.111522713986;5733.025385684444;5753.59724819267;6184.288806787187;6191.504679625619;6197.845053873689;6203.16257305258;6205.162303089115;5670.291213598301;5715.257016587901;5726.112452569859;5741.971290143606;5744.023516002289;5378.112611419072;5383.973080134574;5384.569234461312;5386.461353864583;5390;6207.410296021871;6232.8130156095385;6240.469560087444;6255.812325630239;6257.4994000480765;6148.139260503443;6152.861720581706;6152.907706384497;6202.503799696104;6208.658523781235;6224.719887604978;6250.937490625036;6257.78097766576;6260.154879091447;6278.529110316653;5987.2815262168815;6082.087686847009;6166.352532983972;6172.537059720628;6182.474489668429;5969.253843269591;6123.221615589998;6136.94800169746;6168.414000669929;6175.104609831459;5009.824656137018;6018.067199584071;6049.153118563317;6059.818205453844;6065.120557519223;5902.321233058082;6035;6053.424924632153;6069.362716914837;6089.299730530868;5812.9709351452975;5827.533797296291;5860.853478663067;5880.911786323123;5931.9110213345975;5961.701914904324;6078.756849725962;6079.240094988127;6106.542009349228;6123.785667501795;5870.129353629619;5911.467967882739;5918.615290006136;5922.555808314308;5977.9402205977385 06:39:16 INFO - PROCESS | 1661 | |1;ext.html;476.7759153197996;479.90401919616085;508.6439492355351;536.3376230355508;541.2260467531431;30315.696843031565;40444.393334100016;41239.58760412399;41439;43446;42323.57676423235;42436;42513.57486425135;42519.57480425195;42601.57398426015;9525.38085024473;9718.562664680107;9721.17370023549;9725.0761177688;9729.610815567368;8335;8828.161324674178;9677.225821934227;9685.273604479657;9696.224302055854;9663.130318271355;9710.465924374157;9714.854277185848;9720.805583888317;9722.027797220293;9623.133917947383;9668.75828104296;9669.371490853073;9689.031096890325;9697.660581879636;9558.856617150748;9649.421034737938;9650.71047868565;9651.613935442574;9654.517274136266;40514.79742601298;40822.38766418506;40839.59160408388;40865.1826963462;40898.79550602258;3279.426100432415;3329.1177837872983;3376.1390845334527;3394.9490757638655;3681.5214022176947;25968.09111681101;30121.795128194844;31411.05766826999;31666;31696;3162.193640621627;3189.728873045794;3201.8559164837407;3228.1929517620597;3316.303576248991;445562.77218614024;446257.7687111576;446658;447501;449119;32914.50628240578;33648.15879603029;33782;56868.71565642145;57118.85762284731;34310.485342719876;34933.30133397318;34941.650583493836;34960.650393496246;34990.30019399649;14128.50550230737;14271.78592321116;14281.428742850378;14283.357248923616;14311.212883291311;11970.760584788255;12029.939850300692;12040.21738586989;12061.87938120625;12065.215760975509;7669.808254793675;7714.305712485903;7761.185075566984;7789.571573563395;7791.337736292478;3208.342289830579;3259.674032596721;3261.1355543680816;3266.216108134031;3297.20866991925;977.4282045003753;996.1731762636994;1037.3983089807894;1063.6649455421518;1104.3523599076364;28370.148895533166;28882.566761498594;29045.41909161805;30640;30658.080257592308;883.2801266967401;1064.920130990179;1070.8661417322835;1128.904043156341;1160.9435413773426;14545.98178127521;15343.923280383528;15351.462698805488;15713.528594142193;15787.368505259661;667489;931687;949596;953517;955531;52499.73750131225;55998;56012.439875601536;56119;56121.35211211258;1258.3142187508013;1297.47452281826;1311.206719934445;1334.1794796200268;1369.7397494476018;24543.263702088967;30756.538651920688;30985.605647745455;31132.754689812155;32016.35967280688;54372;54806.45193548014;54857.1599988013;54873.45126548684;54899;610809;613292;615911;616353.918230406;617846;26507.602385964612;26590;27102.3925932588;27248.591271131347;27371.45257094807;46483.3027504581;47786.28320575125;47960.80097997578;48388.03223935572;48487.75756121197;33852.83073584616;37711.62288377081;39399.606003939596;40874.18251634891;41269.793651032756;39068.02329941774;39480.81557553278;39809.33596318152;39814.2037159261;40659.59340406558;32500.349992999534;33138.83430582831;33188.66811331952;33244.83643072481;38753.80623096979;30773;30799.2300192488;33749;34269.800556980386;34446.48330274998;25351.87324063368;25396;25470.363240919127;25635.35911602225;26079.608805868305 06:39:16 INFO - PROCESS | 1661 | |2;jquery.html;364.834000529759;366.88443140410766;370.6886215578914;379.77782996946786;395.3535968691191;19702.310419135334;19812;20073.598528029448;20776.48058798529;20912.268070617494;11501.827472587896;11620.941895290533;11967.222130561508;12001.579944701938;12009.819852702194;4634.629229661619;5464.972675136639;5467.808626698066;5471.042567550682;5479.479449452296;3847.9615203847884;4105.712600117993;4113.4858142732155;7364.33720965113;7860.606969651523;6661.467082633378;7572.962135189344;7848.960755196216;7964.5619490927975;7980.321672657831;7594.8607708843565;7887.723929662463;7914.6438410271385;7956.005499312586;7969.880451793228;7596.886046709304;7647.808804779869;7671.156172820985;7685.077790665156;7689.154193038761;28594.285142871388;28655.57016644752;29007.41985160285;29328;29581.26046848846;3136;3243.157018448996;3262.298605799741;3427.8971630851115;3459.3600183965796;15973.440929567525;17239.74140387895;17665.823341766547;17776.28894844205;18109.909450452797;1973;2042.2035406191596;2061.165228082629;2104.4844013216707;2117.745870495535;107785;136991.31504342513;139080;139721.60278397187;141062;18684.719729204073;20014.598978071394;20725.79274207269;20823.687644685342;21250.78749212488;35156;35250.47124293137;35270.8236458816;35280.64719352774;35334.116647084025;10391.272610917315;10420;10598.31110977784;10829.855818486156;11026.44867756609;7365.81585460357;8801.603927823264;8820.955895220482;8971.693587078238;8992.55037248135;9489.715308540755;9549.427034377959;9632.229421646252;9731.210545122523;9807.656732014346;2396.868172250508;3478.652134786552;3479.9212244204377;3732.2722069196248;3738.700903927679;779.7076096463826;848.749618862437;911.8723378726984;925.1257561604353;990.2573070197352;21172.788272117083;21611.67582486264;21617.243396481048;21619.027143778254;21689;871.6513394642194;878.5738916625431;918.164470332008;955.4171955107379;959.5298303831212;10961.397123158304;11389.259698119597;11411.657650270505;11428.428578571038;11428.885711142948;547823.0003549563;549512;554804;561887;570709;96667;98779;124743;124790;128460;947.8009617980301;949.349695458613;949.8622699708503;961.6826447272383;971.1745016735719;16271.430499932445;18476;18993.810061899203;19044.904775476032;19402.70895936534;44368.66893993186;52560.73719631377;52911.73544132255;53377;53977.46022539724;74037.25962740304;74755.10775259086;81220;82494;83605;6111.877762444815;7883.054033516015;7979.321757650432;8028.4781489203015;8285.95857020711;10303.962908931046;13129.934350328187;13466.259355735137;13555.254461004739;13585.184888906302;11050.613228536962;11402.36562776699;11729.120315976164;11734.002609777923;11748.765024699629;10791.6222932197;10805.081568066802;11297.604583839526;11744.29534227949;11758.470868810753;11423.200375973935;11645.41772911368;11743.295402275891;11845.644630661094;11970.341631210367;7999.400044996765;8082.676692932452;8194.34445244367;8307.127751585997;8340.66637334524;8308.543030133158;11443.656690299304;11484.540618375171;11745.647630571097;11797.646070617895 06:39:16 INFO - PROCESS | 1661 | |3;mootools.html;1329.2689021038427;1530.2654725731647;1568;1792.471220989808;1948.6200190962768;7793.6492857821395;8270.297024752903;8272.62773175207;8281.089080201173;8286.66853325867;8391.748247552569;8689.217970382664;8691.95654021729;8727.781805454866;8745.518996455192;2345.038534200982;2378.4053986503372;2380.3573035280465;2380.8690522021284;2391.378241657173;2168.7746423270883;2185.803277705006;2371.5968285391436;2371.6798232238684;2374.1215750172373;2336.7195936487647;2353.964690529635;2368.159303447277;2373.845700029501;2374.014783864694;2313.421644588853;2338.286822519131;2342.2387723989686;2349.236498138112;2353.1058197884695;2101.7477902651626;2245.1692873636857;2312.3294244669028;2317.7682231776857;2319.761430219846;8656.307495400353;8770.693025744069;8772.473651580925;8792.07683193262;8792.560371981375;5150.819721309774;5169.431362550116;5298.788048478056;5334.333208348957;5338.652987555796;3504.3516949364193;3579.83890724918;3685.1155722626645;3693.4829123922673;3695.097025032084;1027.1372047480152;1057.5663977769077;1061.2200032975757;1079.6005477973122;1083.2254937719567;11238.831417528743;11294.265872718248;11420.972112509913;11421.371824549646;11428.799976002567;4528.848796821483;4589.242774942097;4783.7129772213775;4793.760311984456;4807.975960120177;9900.80198396028;9915.950420247853;9916;9920.603175873028;9930.070629164415;5330.040592693274;5333.173358129496;5337.466253374631;5338.3593968724;5345.144776835766;4122.3404255319;4410.669199810027;4526.185286648435;4549.408576884984;4880.902381952412;3809.7714137151306;3883.6019033148045;3927.2145570885937;3935.409688546684;3949.881503554898;1255.9560415385417;1258.3330834657645;1263.5135472843021;1273.6879464531064;1275.7320962597958;726.596738809955;836.197250639393;892.5537231384308;896.6189369517929;934.4159900062461;5356.250124982505;5667.716614169358;5836.620619659709;5932.3177834548715;5941.415069834342;812.6383759227087;905.7418635688797;926.3098991251561;938.2212763406357;949.9192568631744;3612.4220124780436;3804.1821008483307;3855.3060449118866;3917.4123881418013;3934.7442416243425;9993.600255989824;10445;10460.32007919498;10472.319299245524;10501.842472362921;10134.949325253474;10373.740656483498;10423.270371073952;10439.791204175874;10447.529861156114;7821.335186509211;7930.524168549906;8109.189081091961;8131.308838748772;8141.185881411811;5483.424240454695;5535.944640553543;5624.128260119688;5656.6888821115235;5675.829725108253;9323.114304141096;9479.431234125974;9696.030396960248;9821.558029888814;9924.40453572788;8223.588820559067;9796.922338542898;9907.851382229128;10022.047905448972;10034.899651003396;6519.119918810899;6572.309907459839;6676.198856137295;6683.298253683488;6686.732530698718;8044.959775201087;8077.232662897015;8259.297959673495;8289.33685305162;8311.45975511614;7370.6683199255085;7395.963020184865;7476.327130558276;7502.212267711811;7509.699612015458;7221.566705997657;7310.268973102648;7310.378617817332;7386.2244464332625;7408.185099638928;6839.487038472035;6929.445644348541;6934.098567186234;6934.8613027740175;6956.756513522002;4734.360861283821;4865.099956508057;4888.853334399973;4921.237208232729;5004.699718016931;4852.296417019583;4867.70793752376;5001.524855138756;5053.343065401621;5090.389153301628 06:39:16 INFO - PROCESS | 1661 | |4;prototype.html;286.56156081195763;293.5010482180293;297.6918888949936;299.55216950658763;300.8149987757527;5177.818776342829;5325.920111198335;5372.892542149159;5416.485433883775;5448.0114758113305;4317;4508.8647340579755;4956;5120.103981803179;5124.359455068116;3637.3816451203224;4043.555208927016;4049.048473608707;4082.7547597982602;4106.733062350952;3412.8293585320635;4079.286699586181;4092.85675001375;4105.973506623344;4137.751734895915;3139.3878193752225;3581.3374525712825;3803.7337386382965;3895.5520115186832;4047.615476529725;4030.294698427793;4053.223541873826;4068.593140685937;4073.6130067643526;4109.671226301889;3509.9649003509894;3515.1739341254784;3516.49010893419;3533.487644291589;3556.466530020492;4066.207089617526;4546.613537849286;4668.836590719308;5134.17853143499;5258.50044245796;3500.9649903500895;4193.559676234013;4246.256905041636;4348.652107831366;4512.390827238313;5200.869978250536;5597.59303499495;5643.209950606918;5646.915296270559;5651.163371904147;3086.8919587814544;3415.7438192135687;3619.4751760994773;3619.9457008144636;3820.2359528094216;5661.801836935729;5847.44449277318;5873.706314684248;5877.148698160108;5889.234399528077;3653.8538458461894;3799.2021675447913;3806.81108362687;3808.324337291638;3828.578856325802;3349.69852713257;3357.7145942594666;3494.021673931303;3868.458415821787;3899.337112690849;4147.81334839933;4215.946013496626;4412.558744125626;4568.543145685405;4588.27939522679;4688.718676879398;5429.479745671219;5651.208830763697;5673.631213971079;5697.521578113534;1127.3686735428187;1219.8655250617012;1299.07087974358;1314.7633425983415;1332.4470344806796;762.7025460070577;821.7904434369317;827.2596026556198;844.3118858130604;847.9491230526065;4976.925346119811;5090.516400941905;5283.867903302448;5294.867628309246;5319.973400133052;4972.5027497249985;5404.3784964728775;5737.934343636288;5749.540036797046;5758.337791153987;5054.418741844662;5208.817691380784;5255.973720131451;5256.26412302278;5262.500062494057;2526.3810366460334;2638.379980704533;2727.318170457386;3010.4280186764445;3014.6081009469067;5328.254044433782;5645.80239691617;5706.28671416073;5829.533637309005;5889.263842019747;5348.572114230852;5604;5617.21359009739;5673.858153546112;5844.532437405082;5623.437656234344;5844.327902291206;5877.353491115974;5880.0591905295805;5950.880982380241;4870.902581948412;5054.721990290569;5191.250006244244;5561.332640083216;5649.745761440663;4821.601735496667;5759.7408116634015;5759.884802304015;5769.53843692512;5782.571320045675;5278.9706007328205;5779.768809247583;5944.970275148597;5980.760769569169;6009.639421634716;3304.4052070627517;3484.285721427152;3512.4028915083986;3894.9221015578964;3896.8246428911334;5659.122835960433;5826.359100498857;5899.262592175978;5902.881942361215;5938.2280303560265;5242.816501422432;5363.731813409236;5669.262995810518;5706.400827913009;5768.365479797135;4717.504662010577;5185.792568297225;5630.183623374506;5633.352164501135;5677.971610141923;4720.339152518719;4916;5276.287701160294;5420.214068960057;5512.704514439023;5099.592032637306;5529.30883639545;5543.833684989457;5550.222968784293;5552.167174923794;5543.445655434424;5571.66570005801;5574.9442505574425;5590;5599.188117722826 06:39:16 INFO - PROCESS | 1661 | |5;yui.html;726.7383741852932;740.7703611880318;750.0249675421957;761.2387612387608;789.6762327445747;15520.534383968485;15749.527514174593;15753.212339383028;15756.527304180865;15827.129507877076;14178.291085445739;14257.71484570308;14280.357383917722;14291;14333.498327558538;717.2755516927914;737.9926400463356;893.3567831161586;911.08436021798;928.2388441477991;924.2375040591505;930.0978051290238;937.1659223291276;940.6190492850407;942.3497786527308;978.9314747967645;979.6816034788723;979.9559019844124;980.8185485685171;983.5819776594955;972.3776782858976;974.512743628186;977.5698692575244;978.535195782005;981.8036392721449;560.4115678537519;580.274656679151;701.5580184483742;716.9247229040927;726.1286456252518;15135.318910649048;15161.469348572857;15176.620584485367;15206.239688015665;15262.694746105015;13526.526571570046;14052.508162214273;14105.788413173708;14289.142651440947;14344;12135.332556709378;12595.937020314932;12644.051696122735;12647.43086561107;12702.555410560586;4471.6199123074575;4562.087582483517;4564.908701825945;4637;4667.6732628716;110970;111472;111842.44078779554;114050.92294111203;114426.85573144245;11007.449627518752;11097.722556936142;11229.157813164045;11248.381339026268;11259.94370028161;22463.989120489616;22502.774972250394;22505;22508.887455562617;22515.88742056279;7797.5335545539865;8101.8379632408205;8110.148434414419;8188.5905704715715;8196.385271104691;4388.429504164438;4412.271975124133;4473;4530.954690453053;4608.377868987711;3377.4933759936207;3511.7717348372275;3521.0669172669263;3523.612402635708;3524.1189702574356;628.2649300318639;644.9000404937242;652.0414989964744;654.2835595023441;660.8810414125503;588.7233000489763;595.9523238140938;611.8164550634792;627.3444250757968;645.5223134880155;8450.788730281669;8903.55482225886;8906.643734250687;8932.06207364257;9055.773605659911;592.1413949772847;608.9817305480842;621.2638023941644;627.3444250757968;636.7421194416269;3668.724845636588;4366.825326986948;4378.16814805186;4519.887002824956;4523.2054022736;145891.2705436466;149082;149813;150909;157212;103062.48468757758;103311.9999999985;104069;122060;124209;97760.51119744356;97868;99695.50152249192;101953;102343.23052849018;8278.917210827814;9730.318877678494;9896;9952.900470995197;9964.10323070927;58123.700207966525;58484.70757646184;58792;60004.69997649984;60125.09812352906;81443.5566932993;85583.71624425764;88714.55642721745;90230;91607.54196228976;12524.330960960326;12945.352732363532;13030.348482575644;13383.263920484467;13749.800031994833;14238.790771043134;14259.42962281497;14661.669046485647;14738.778918316018;14794.77807832905;13398.799018014543;13429.932850335686;13449.125806822525;13498.214232418615;13784.655383615489;13454.663633409244;13619.863801362257;13695.589132326046;13735.656608584466;14116;13251.734965300833;13394.93302533481;13411.329433528479;13422.328883555978;13441.932790335986;10927.83608245861;11058.889411106107;11436.428178591204;11633.389415799293;11634.70913227176;10822.458877056273;11255.911770715675;11305.604303849326;11339.206255562032;11404.714882128013 06:39:16 INFO - PROCESS | 1661 | __end_tp_report 06:39:16 INFO - PROCESS | 1661 | __start_cc_report 06:39:16 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1825 06:39:16 INFO - PROCESS | 1661 | __end_cc_report 06:39:16 INFO - PROCESS | 1661 | __startTimestamp1476970756816__endTimestamp 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | ------- Summary: start ------- 06:39:16 INFO - PROCESS | 1661 | Number of tests: 6 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5697.45 Median:5902.32 stddev:642.19 (10.9%) stddev-sans-first:602.51 06:39:16 INFO - PROCESS | 1661 | Values: 2797.5 3327.2 3327.9 3360.6 3375.3 4525.3 5651.8 5662.2 5710.0 5730.4 5686.1 5704.5 5705.3 5708.3 5718.9 5155.2 5182.2 5198.6 5230.6 5277.2 5182.1 5224.4 5229.0 5287.8 5309.2 5261.3 5301.9 5330.8 5345.6 5359.8 5275.6 5290.9 5292.7 5299.9 5350.9 4972.6 5008.7 5211.7 5216.5 5221.3 5589.9 5626.9 5671.7 5732.8 5756.9 5103.4 6113.6 6117.2 6168.9 6172.8 6190.1 6203.7 6245.7 6263.1 6269.2 5597.7 5748.0 5749.7 5777.9 5848.3 6182.3 6183.2 6191.1 6226.3 6238.9 6041.4 6054.9 6073.8 6114.4 6132.9 6222.9 6235.0 6257.2 6271.8 6278.5 5992.9 6063.9 6091.7 6108.1 6127.8 6225.4 6238.3 6244.8 6246.7 6251.2 4907.1 4907.6 4910.9 4912.8 4937.5 4341.5 4364.6 4365.3 4455.0 4465.8 5699.5 5728.7 5732.1 5733.0 5753.6 6184.3 6191.5 6197.8 6203.2 6205.2 5670.3 5715.3 5726.1 5742.0 5744.0 5378.1 5384.0 5384.6 5386.5 5390.0 6207.4 6232.8 6240.5 6255.8 6257.5 6148.1 6152.9 6152.9 6202.5 6208.7 6224.7 6250.9 6257.8 6260.2 6278.5 5987.3 6082.1 6166.4 6172.5 6182.5 5969.3 6123.2 6136.9 6168.4 6175.1 5009.8 6018.1 6049.2 6059.8 6065.1 5902.3 6035.0 6053.4 6069.4 6089.3 5813.0 5827.5 5860.9 5880.9 5931.9 5961.7 6078.8 6079.2 6106.5 6123.8 5870.1 5911.5 5918.6 5922.6 5977.9 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:75286.59 Median:39645.08 stddev:183726.43 (463.4%) stddev-sans-first:184155.97 06:39:16 INFO - PROCESS | 1661 | Values: 476.8 479.9 508.6 536.3 541.2 30315.7 40444.4 41239.6 41439.0 43446.0 42323.6 42436.0 42513.6 42519.6 42601.6 9525.4 9718.6 9721.2 9725.1 9729.6 8335.0 8828.2 9677.2 9685.3 9696.2 9663.1 9710.5 9714.9 9720.8 9722.0 9623.1 9668.8 9669.4 9689.0 9697.7 9558.9 9649.4 9650.7 9651.6 9654.5 40514.8 40822.4 40839.6 40865.2 40898.8 3279.4 3329.1 3376.1 3394.9 3681.5 25968.1 30121.8 31411.1 31666.0 31696.0 3162.2 3189.7 3201.9 3228.2 3316.3 445562.8 446257.8 446658.0 447501.0 449119.0 32914.5 33648.2 33782.0 56868.7 57118.9 34310.5 34933.3 34941.7 34960.7 34990.3 14128.5 14271.8 14281.4 14283.4 14311.2 11970.8 12029.9 12040.2 12061.9 12065.2 7669.8 7714.3 7761.2 7789.6 7791.3 3208.3 3259.7 3261.1 3266.2 3297.2 977.4 996.2 1037.4 1063.7 1104.4 28370.1 28882.6 29045.4 30640.0 30658.1 883.3 1064.9 1070.9 1128.9 1160.9 14546.0 15343.9 15351.5 15713.5 15787.4 667489.0 931687.0 949596.0 953517.0 955531.0 52499.7 55998.0 56012.4 56119.0 56121.4 1258.3 1297.5 1311.2 1334.2 1369.7 24543.3 30756.5 30985.6 31132.8 32016.4 54372.0 54806.5 54857.2 54873.5 54899.0 610809.0 613292.0 615911.0 616353.9 617846.0 26507.6 26590.0 27102.4 27248.6 27371.5 46483.3 47786.3 47960.8 48388.0 48487.8 33852.8 37711.6 39399.6 40874.2 41269.8 39068.0 39480.8 39809.3 39814.2 40659.6 32500.3 33138.8 33188.7 33244.8 38753.8 30773.0 30799.2 33749.0 34269.8 34446.5 25351.9 25396.0 25470.4 25635.4 26079.6 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35259.41 Median:35203.24 stddev:93246.77 (264.9%) stddev-sans-first:93471.55 06:39:16 INFO - PROCESS | 1661 | Values: 364.8 366.9 370.7 379.8 395.4 19702.3 19812.0 20073.6 20776.5 20912.3 11501.8 11620.9 11967.2 12001.6 12009.8 4634.6 5465.0 5467.8 5471.0 5479.5 3848.0 4105.7 4113.5 7364.3 7860.6 6661.5 7573.0 7849.0 7964.6 7980.3 7594.9 7887.7 7914.6 7956.0 7969.9 7596.9 7647.8 7671.2 7685.1 7689.2 28594.3 28655.6 29007.4 29328.0 29581.3 3136.0 3243.2 3262.3 3427.9 3459.4 15973.4 17239.7 17665.8 17776.3 18109.9 1973.0 2042.2 2061.2 2104.5 2117.7 107785.0 136991.3 139080.0 139721.6 141062.0 18684.7 20014.6 20725.8 20823.7 21250.8 35156.0 35250.5 35270.8 35280.6 35334.1 10391.3 10420.0 10598.3 10829.9 11026.4 7365.8 8801.6 8821.0 8971.7 8992.6 9489.7 9549.4 9632.2 9731.2 9807.7 2396.9 3478.7 3479.9 3732.3 3738.7 779.7 848.7 911.9 925.1 990.3 21172.8 21611.7 21617.2 21619.0 21689.0 871.7 878.6 918.2 955.4 959.5 10961.4 11389.3 11411.7 11428.4 11428.9 547823.0 549512.0 554804.0 561887.0 570709.0 96667.0 98779.0 124743.0 124790.0 128460.0 947.8 949.3 949.9 961.7 971.2 16271.4 18476.0 18993.8 19044.9 19402.7 44368.7 52560.7 52911.7 53377.0 53977.5 74037.3 74755.1 81220.0 82494.0 83605.0 6111.9 7883.1 7979.3 8028.5 8286.0 10304.0 13129.9 13466.3 13555.3 13585.2 11050.6 11402.4 11729.1 11734.0 11748.8 10791.6 10805.1 11297.6 11744.3 11758.5 11423.2 11645.4 11743.3 11845.6 11970.3 7999.4 8082.7 8194.3 8307.1 8340.7 8308.5 11443.7 11484.5 11745.6 11797.6 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5586.13 Median:5120.60 stddev:3102.80 (60.6%) stddev-sans-first:3095.01 06:39:16 INFO - PROCESS | 1661 | Values: 1329.3 1530.3 1568.0 1792.5 1948.6 7793.6 8270.3 8272.6 8281.1 8286.7 8391.7 8689.2 8692.0 8727.8 8745.5 2345.0 2378.4 2380.4 2380.9 2391.4 2168.8 2185.8 2371.6 2371.7 2374.1 2336.7 2354.0 2368.2 2373.8 2374.0 2313.4 2338.3 2342.2 2349.2 2353.1 2101.7 2245.2 2312.3 2317.8 2319.8 8656.3 8770.7 8772.5 8792.1 8792.6 5150.8 5169.4 5298.8 5334.3 5338.7 3504.4 3579.8 3685.1 3693.5 3695.1 1027.1 1057.6 1061.2 1079.6 1083.2 11238.8 11294.3 11421.0 11421.4 11428.8 4528.8 4589.2 4783.7 4793.8 4808.0 9900.8 9916.0 9916.0 9920.6 9930.1 5330.0 5333.2 5337.5 5338.4 5345.1 4122.3 4410.7 4526.2 4549.4 4880.9 3809.8 3883.6 3927.2 3935.4 3949.9 1256.0 1258.3 1263.5 1273.7 1275.7 726.6 836.2 892.6 896.6 934.4 5356.3 5667.7 5836.6 5932.3 5941.4 812.6 905.7 926.3 938.2 949.9 3612.4 3804.2 3855.3 3917.4 3934.7 9993.6 10445.0 10460.3 10472.3 10501.8 10134.9 10373.7 10423.3 10439.8 10447.5 7821.3 7930.5 8109.2 8131.3 8141.2 5483.4 5535.9 5624.1 5656.7 5675.8 9323.1 9479.4 9696.0 9821.6 9924.4 8223.6 9796.9 9907.9 10022.0 10034.9 6519.1 6572.3 6676.2 6683.3 6686.7 8045.0 8077.2 8259.3 8289.3 8311.5 7370.7 7396.0 7476.3 7502.2 7509.7 7221.6 7310.3 7310.4 7386.2 7408.2 6839.5 6929.4 6934.1 6934.9 6956.8 4734.4 4865.1 4888.9 4921.2 5004.7 4852.3 4867.7 5001.5 5053.3 5090.4 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4494.61 Median:5156.00 stddev:1425.86 (27.7%) stddev-sans-first:1394.44 06:39:16 INFO - PROCESS | 1661 | Values: 286.6 293.5 297.7 299.6 300.8 5177.8 5325.9 5372.9 5416.5 5448.0 4317.0 4508.9 4956.0 5120.1 5124.4 3637.4 4043.6 4049.0 4082.8 4106.7 3412.8 4079.3 4092.9 4106.0 4137.8 3139.4 3581.3 3803.7 3895.6 4047.6 4030.3 4053.2 4068.6 4073.6 4109.7 3510.0 3515.2 3516.5 3533.5 3556.5 4066.2 4546.6 4668.8 5134.2 5258.5 3501.0 4193.6 4246.3 4348.7 4512.4 5200.9 5597.6 5643.2 5646.9 5651.2 3086.9 3415.7 3619.5 3619.9 3820.2 5661.8 5847.4 5873.7 5877.1 5889.2 3653.9 3799.2 3806.8 3808.3 3828.6 3349.7 3357.7 3494.0 3868.5 3899.3 4147.8 4215.9 4412.6 4568.5 4588.3 4688.7 5429.5 5651.2 5673.6 5697.5 1127.4 1219.9 1299.1 1314.8 1332.4 762.7 821.8 827.3 844.3 847.9 4976.9 5090.5 5283.9 5294.9 5320.0 4972.5 5404.4 5737.9 5749.5 5758.3 5054.4 5208.8 5256.0 5256.3 5262.5 2526.4 2638.4 2727.3 3010.4 3014.6 5328.3 5645.8 5706.3 5829.5 5889.3 5348.6 5604.0 5617.2 5673.9 5844.5 5623.4 5844.3 5877.4 5880.1 5950.9 4870.9 5054.7 5191.3 5561.3 5649.7 4821.6 5759.7 5759.9 5769.5 5782.6 5279.0 5779.8 5945.0 5980.8 6009.6 3304.4 3484.3 3512.4 3894.9 3896.8 5659.1 5826.4 5899.3 5902.9 5938.2 5242.8 5363.7 5669.3 5706.4 5768.4 4717.5 5185.8 5630.2 5633.4 5678.0 4720.3 4916.0 5276.3 5420.2 5512.7 5099.6 5529.3 5543.8 5550.2 5552.2 5543.4 5571.7 5574.9 5590.0 5599.2 06:39:16 INFO - PROCESS | 1661 | 06:39:16 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24102.40 Median:3523.87 stddev:37839.80 (1073.8%) stddev-sans-first:37905.24 06:39:16 INFO - PROCESS | 1661 | Values: 726.7 740.8 750.0 761.2 789.7 15520.5 15749.5 15753.2 15756.5 15827.1 14178.3 14257.7 14280.4 14291.0 14333.5 717.3 738.0 893.4 911.1 928.2 924.2 930.1 937.2 940.6 942.3 978.9 979.7 980.0 980.8 983.6 972.4 974.5 977.6 978.5 981.8 560.4 580.3 701.6 716.9 726.1 15135.3 15161.5 15176.6 15206.2 15262.7 13526.5 14052.5 14105.8 14289.1 14344.0 12135.3 12595.9 12644.1 12647.4 12702.6 4471.6 4562.1 4564.9 4637.0 4667.7 110970.0 111472.0 111842.4 114050.9 114426.9 11007.4 11097.7 11229.2 11248.4 11259.9 22464.0 22502.8 22505.0 22508.9 22515.9 7797.5 8101.8 8110.1 8188.6 8196.4 4388.4 4412.3 4473.0 4531.0 4608.4 3377.5 3511.8 3521.1 3523.6 3524.1 628.3 644.9 652.0 654.3 660.9 588.7 596.0 611.8 627.3 645.5 8450.8 8903.6 8906.6 8932.1 9055.8 592.1 609.0 621.3 627.3 636.7 3668.7 4366.8 4378.2 4519.9 4523.2 145891.3 149082.0 149813.0 150909.0 157212.0 103062.5 103312.0 104069.0 122060.0 124209.0 97760.5 97868.0 99695.5 101953.0 102343.2 8278.9 9730.3 9896.0 9952.9 9964.1 58123.7 58484.7 58792.0 60004.7 60125.1 81443.6 85583.7 88714.6 90230.0 91607.5 12524.3 12945.4 13030.3 13383.3 13749.8 14238.8 14259.4 14661.7 14738.8 14794.8 13398.8 13429.9 13449.1 13498.2 13784.7 13454.7 13619.9 13695.6 13735.7 14116.0 13251.7 13394.9 13411.3 13422.3 13441.9 10927.8 11058.9 11436.4 11633.4 11634.7 10822.5 11255.9 11305.6 11339.2 11404.7 06:39:16 INFO - PROCESS | 1661 | -------- Summary: end -------- 06:39:16 INFO - PROCESS | 1661 | 06:39:17 INFO - TEST-INFO | 1661: exit 0 06:39:17 INFO - TEST-OK | dromaeo_css | took 1119672ms 06:39:17 INFO - TEST-START | kraken 06:39:17 INFO - operating with platform_type : mac_ 06:39:17 INFO - Initialising browser for kraken test... 06:39:17 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmp7xzYzv/profile http://localhost:49276/getInfo.html) 06:39:19 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 06:39:19 INFO - PROCESS | 1669 | colorDepth:24 06:39:19 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 06:39:19 INFO - PROCESS | 1669 | __metrics 06:39:19 INFO - PROCESS | 1669 | 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" 06:39:19 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:20 INFO - TEST-INFO | 1669: exit 0 06:39:20 INFO - Browser initialized. 06:39:20 INFO - Running cycle 1/1 for kraken test... 06:39:20 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmp7xzYzv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:32 INFO - PROCESS | 1671 | RSS: Main: 231940096 06:39:32 INFO - PROCESS | 1671 | 06:39:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 06:39:36 INFO - PROCESS | 1671 | RSS: Main: 291049472 06:39:36 INFO - PROCESS | 1671 | 06:39:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 06:39:39 INFO - PROCESS | 1671 | RSS: Main: 292474880 06:39:39 INFO - PROCESS | 1671 | 06:39:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 06:39:43 INFO - PROCESS | 1671 | RSS: Main: 386752512 06:39:43 INFO - PROCESS | 1671 | 06:39:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 06:39:46 INFO - PROCESS | 1671 | RSS: Main: 286613504 06:39:46 INFO - PROCESS | 1671 | 06:39:48 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:39:49 INFO - PROCESS | 1671 | RSS: Main: 290623488 06:39:49 INFO - PROCESS | 1671 | 06:39:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 06:39:52 INFO - PROCESS | 1671 | RSS: Main: 330330112 06:39:52 INFO - PROCESS | 1671 | 06:39:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 06:39:55 INFO - PROCESS | 1671 | RSS: Main: 331395072 06:39:55 INFO - PROCESS | 1671 | 06:39:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 06:39:59 INFO - PROCESS | 1671 | RSS: Main: 327102464 06:39:59 INFO - PROCESS | 1671 | 06:40:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:40:01 INFO - PROCESS | 1671 | RSS: Main: 303230976 06:40:01 INFO - PROCESS | 1671 | 06:40:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:40:03 INFO - PROCESS | 1671 | RSS: Main: 306151424 06:40:03 INFO - PROCESS | 1671 | 06:40:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:40:06 INFO - PROCESS | 1671 | RSS: Main: 310333440 06:40:06 INFO - PROCESS | 1671 | 06:40:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:40:10 INFO - PROCESS | 1671 | RSS: Main: 319938560 06:40:10 INFO - PROCESS | 1671 | 06:40:13 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:40:14 INFO - PROCESS | 1671 | RSS: Main: 319385600 06:40:14 INFO - PROCESS | 1671 | 06:40:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 06:40:16 INFO - PROCESS | 1671 | RSS: Main: 363040768 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | __start_tp_report 06:40:16 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 06:40:16 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 06:40:16 INFO - PROCESS | 1671 | |i|pagename|runs| 06:40:16 INFO - PROCESS | 1671 | |0;ai-astar;104;114;120;163;157;114;114;115;114;114 06:40:16 INFO - PROCESS | 1671 | |1;audio-beat-detection;149;132;103;165;139;138;99;133;173;141 06:40:16 INFO - PROCESS | 1671 | |2;audio-dft;185;181;183;185;184;189;182;183;180;183 06:40:16 INFO - PROCESS | 1671 | |3;audio-fft;80;69;57;88;58;75;82;82;96;57 06:40:16 INFO - PROCESS | 1671 | |4;audio-oscillator;87;70;89;69;68;68;91;66;68;94 06:40:16 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;90;84;88;85;87;86;89;87;89;84 06:40:16 INFO - PROCESS | 1671 | |6;imaging-darkroom;97;94;94;94;94;93;94;94;95;94 06:40:16 INFO - PROCESS | 1671 | |7;imaging-desaturate;83;83;79;81;84;83;87;86;85;81 06:40:16 INFO - PROCESS | 1671 | |8;json-parse-financial;60;57;56;56;56;57;57;57;56;57 06:40:16 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;67;75;82;75;72;70;68;70;71;72 06:40:16 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;90;84;85;85;89;83;88;85;99;105 06:40:16 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;148;146;146;148;146;121;144;154;205;148 06:40:16 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;173;172;173;171;171;171;172;171;169;171 06:40:16 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;70;72;86;85;83;79;71;68;66;69 06:40:16 INFO - PROCESS | 1671 | __end_tp_report 06:40:16 INFO - PROCESS | 1671 | __start_cc_report 06:40:16 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1960 06:40:16 INFO - PROCESS | 1671 | __end_cc_report 06:40:16 INFO - PROCESS | 1671 | __startTimestamp1476970816155__endTimestamp 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | ------- Summary: start ------- 06:40:16 INFO - PROCESS | 1671 | Number of tests: 14 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:122.90 Median:114.50 stddev:19.99 (17.5%) stddev-sans-first:19.99 06:40:16 INFO - PROCESS | 1671 | Values: 104.0 114.0 120.0 163.0 157.0 114.0 114.0 115.0 114.0 114.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:145.00 stddev:23.30 (16.1%) stddev-sans-first:24.32 06:40:16 INFO - PROCESS | 1671 | Values: 149.0 132.0 103.0 165.0 139.0 138.0 99.0 133.0 173.0 141.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:2.51 (1.4%) stddev-sans-first:2.60 06:40:16 INFO - PROCESS | 1671 | Values: 185.0 181.0 183.0 185.0 184.0 189.0 182.0 183.0 180.0 183.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:74.40 Median:81.00 stddev:13.75 (17.0%) stddev-sans-first:14.44 06:40:16 INFO - PROCESS | 1671 | Values: 80.0 69.0 57.0 88.0 58.0 75.0 82.0 82.0 96.0 57.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:11.58 (14.7%) stddev-sans-first:11.70 06:40:16 INFO - PROCESS | 1671 | Values: 87.0 70.0 89.0 69.0 68.0 68.0 91.0 66.0 68.0 94.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:2.13 (2.4%) stddev-sans-first:1.94 06:40:16 INFO - PROCESS | 1671 | Values: 90.0 84.0 88.0 85.0 87.0 86.0 89.0 87.0 89.0 84.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.06 (1.1%) stddev-sans-first:0.50 06:40:16 INFO - PROCESS | 1671 | Values: 97.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:83.20 Median:83.50 stddev:2.44 (2.9%) stddev-sans-first:2.59 06:40:16 INFO - PROCESS | 1671 | Values: 83.0 83.0 79.0 81.0 84.0 83.0 87.0 86.0 85.0 81.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:0.53 06:40:16 INFO - PROCESS | 1671 | Values: 60.0 57.0 56.0 56.0 56.0 57.0 57.0 57.0 56.0 57.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:4.32 (6.0%) stddev-sans-first:4.15 06:40:16 INFO - PROCESS | 1671 | Values: 67.0 75.0 82.0 75.0 72.0 70.0 68.0 70.0 71.0 72.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:86.50 stddev:7.20 (8.3%) stddev-sans-first:7.63 06:40:16 INFO - PROCESS | 1671 | Values: 90.0 84.0 85.0 85.0 89.0 83.0 88.0 85.0 99.0 105.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:148.00 stddev:21.01 (14.2%) stddev-sans-first:22.27 06:40:16 INFO - PROCESS | 1671 | Values: 148.0 146.0 146.0 148.0 146.0 121.0 144.0 154.0 205.0 148.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:1.17 (0.7%) stddev-sans-first:1.09 06:40:16 INFO - PROCESS | 1671 | Values: 173.0 172.0 173.0 171.0 171.0 171.0 172.0 171.0 169.0 171.0 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.50 stddev:7.58 (10.0%) stddev-sans-first:7.83 06:40:16 INFO - PROCESS | 1671 | Values: 70.0 72.0 86.0 85.0 83.0 79.0 71.0 68.0 66.0 69.0 06:40:16 INFO - PROCESS | 1671 | -------- Summary: end -------- 06:40:16 INFO - PROCESS | 1671 | 06:40:16 INFO - TEST-INFO | 1671: exit 0 06:40:17 INFO - TEST-OK | kraken | took 59561ms 06:40:17 INFO - SUITE-END | took 1179s 06:40:17 INFO - Completed test suite (00:19:39) 06:40:17 INFO - javascript benchmark 06:40:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2797.454496373207, 3327.2347360107183, 3327.883524076658, 3360.5967283925934, 3375.3249350129963, 4525.275955847065, 5651.773929042838, 5662.207290979256, 5709.971450142749, 5730.4269573042675, 5686.118651609007, 5704.458076482738, 5705.25831641887, 5708.257926469553, 5718.885622287562, 5155.226715992603, 5182.2226666000215, 5198.636095473299, 5230.555402790767, 5277.1556550951855, 5182.119039763249, 5224.399194092671, 5229.0, 5287.762050707708, 5309.203619457074, 5261.342332208474, 5301.920471192935, 5330.840074797762, 5345.625806193568, 5359.839204823861, 5275.604329675251, 5290.92063619046, 5292.682439053669, 5299.920501192485, 5350.892982140335, 4972.552470277692, 5008.749562521859, 5211.661242019257, 5216.452272511369, 5221.347331583552, 5589.888202235932, 5626.9437305626825, 5671.7164141793155, 5732.828015159552, 5756.942430575725, 5103.387593488768, 6113.633182009094, 6117.235345581802, 6168.87662246757, 6172.783952561639, 6190.133381326618, 6203.728235711714, 6245.656488893109, 6263.060540918853, 6269.185005949197, 5597.720113994284, 5747.971260143672, 5749.741261643236, 5777.8555536111935, 5848.298204215522, 6182.258129024546, 6183.165272688129, 6191.102290167901, 6226.25284965807, 6238.875222495525, 6041.395860414012, 6054.8882522058975, 6073.75704971805, 6114.419130182626, 6132.877342453126, 6222.875542489125, 6234.9688251559355, 6257.2491301044165, 6271.78048768291, 6278.466330361879, 5992.850178745566, 6063.9090413643835, 6091.664958427329, 6108.1143234230785, 6127.846803829851, 6225.408586184305, 6238.344973777779, 6244.781432649836, 6246.6876656167005, 6251.156093927261, 4907.092187945242, 4907.55831975124, 4910.852674419773, 4912.8280510182685, 4937.530934561211, 4341.45731783527, 4364.5635436456105, 4365.279728844768, 4454.977725111354, 4465.754383508938, 5699.544036477072, 5728.684922329228, 5732.111522713986, 5733.025385684444, 5753.59724819267, 6184.288806787187, 6191.504679625619, 6197.845053873689, 6203.16257305258, 6205.162303089115, 5670.291213598301, 5715.257016587901, 5726.112452569859, 5741.971290143606, 5744.023516002289, 5378.112611419072, 5383.973080134574, 5384.569234461312, 5386.461353864583, 5390.0, 6207.410296021871, 6232.8130156095385, 6240.469560087444, 6255.812325630239, 6257.4994000480765, 6148.139260503443, 6152.861720581706, 6152.907706384497, 6202.503799696104, 6208.658523781235, 6224.719887604978, 6250.937490625036, 6257.78097766576, 6260.154879091447, 6278.529110316653, 5987.2815262168815, 6082.087686847009, 6166.352532983972, 6172.537059720628, 6182.474489668429, 5969.253843269591, 6123.221615589998, 6136.94800169746, 6168.414000669929, 6175.104609831459, 5009.824656137018, 6018.067199584071, 6049.153118563317, 6059.818205453844, 6065.120557519223, 5902.321233058082, 6035.0, 6053.424924632153, 6069.362716914837, 6089.299730530868, 5812.9709351452975, 5827.533797296291, 5860.853478663067, 5880.911786323123, 5931.9110213345975, 5961.701914904324, 6078.756849725962, 6079.240094988127, 6106.542009349228, 6123.785667501795, 5870.129353629619, 5911.467967882739, 5918.615290006136, 5922.555808314308, 5977.9402205977385], "value": 5655.766125997963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.7759153197996, 479.90401919616085, 508.6439492355351, 536.3376230355508, 541.2260467531431, 30315.696843031565, 40444.393334100016, 41239.58760412399, 41439.0, 43446.0, 42323.57676423235, 42436.0, 42513.57486425135, 42519.57480425195, 42601.57398426015, 9525.38085024473, 9718.562664680107, 9721.17370023549, 9725.0761177688, 9729.610815567368, 8335.0, 8828.161324674178, 9677.225821934227, 9685.273604479657, 9696.224302055854, 9663.130318271355, 9710.465924374157, 9714.854277185848, 9720.805583888317, 9722.027797220293, 9623.133917947383, 9668.75828104296, 9669.371490853073, 9689.031096890325, 9697.660581879636, 9558.856617150748, 9649.421034737938, 9650.71047868565, 9651.613935442574, 9654.517274136266, 40514.79742601298, 40822.38766418506, 40839.59160408388, 40865.1826963462, 40898.79550602258, 3279.426100432415, 3329.1177837872983, 3376.1390845334527, 3394.9490757638655, 3681.5214022176947, 25968.09111681101, 30121.795128194844, 31411.05766826999, 31666.0, 31696.0, 3162.193640621627, 3189.728873045794, 3201.8559164837407, 3228.1929517620597, 3316.303576248991, 445562.77218614024, 446257.7687111576, 446658.0, 447501.0, 449119.0, 32914.50628240578, 33648.15879603029, 33782.0, 56868.71565642145, 57118.85762284731, 34310.485342719876, 34933.30133397318, 34941.650583493836, 34960.650393496246, 34990.30019399649, 14128.50550230737, 14271.78592321116, 14281.428742850378, 14283.357248923616, 14311.212883291311, 11970.760584788255, 12029.939850300692, 12040.21738586989, 12061.87938120625, 12065.215760975509, 7669.808254793675, 7714.305712485903, 7761.185075566984, 7789.571573563395, 7791.337736292478, 3208.342289830579, 3259.674032596721, 3261.1355543680816, 3266.216108134031, 3297.20866991925, 977.4282045003753, 996.1731762636994, 1037.3983089807894, 1063.6649455421518, 1104.3523599076364, 28370.148895533166, 28882.566761498594, 29045.41909161805, 30640.0, 30658.080257592308, 883.2801266967401, 1064.920130990179, 1070.8661417322835, 1128.904043156341, 1160.9435413773426, 14545.98178127521, 15343.923280383528, 15351.462698805488, 15713.528594142193, 15787.368505259661, 667489.0, 931687.0, 949596.0, 953517.0, 955531.0, 52499.73750131225, 55998.0, 56012.439875601536, 56119.0, 56121.35211211258, 1258.3142187508013, 1297.47452281826, 1311.206719934445, 1334.1794796200268, 1369.7397494476018, 24543.263702088967, 30756.538651920688, 30985.605647745455, 31132.754689812155, 32016.35967280688, 54372.0, 54806.45193548014, 54857.1599988013, 54873.45126548684, 54899.0, 610809.0, 613292.0, 615911.0, 616353.918230406, 617846.0, 26507.602385964612, 26590.0, 27102.3925932588, 27248.591271131347, 27371.45257094807, 46483.3027504581, 47786.28320575125, 47960.80097997578, 48388.03223935572, 48487.75756121197, 33852.83073584616, 37711.62288377081, 39399.606003939596, 40874.18251634891, 41269.793651032756, 39068.02329941774, 39480.81557553278, 39809.33596318152, 39814.2037159261, 40659.59340406558, 32500.349992999534, 33138.83430582831, 33188.66811331952, 33244.83643072481, 38753.80623096979, 30773.0, 30799.2300192488, 33749.0, 34269.800556980386, 34446.48330274998, 25351.87324063368, 25396.0, 25470.363240919127, 25635.35911602225, 26079.608805868305], "value": 18595.059351211516, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.834000529759, 366.88443140410766, 370.6886215578914, 379.77782996946786, 395.3535968691191, 19702.310419135334, 19812.0, 20073.598528029448, 20776.48058798529, 20912.268070617494, 11501.827472587896, 11620.941895290533, 11967.222130561508, 12001.579944701938, 12009.819852702194, 4634.629229661619, 5464.972675136639, 5467.808626698066, 5471.042567550682, 5479.479449452296, 3847.9615203847884, 4105.712600117993, 4113.4858142732155, 7364.33720965113, 7860.606969651523, 6661.467082633378, 7572.962135189344, 7848.960755196216, 7964.5619490927975, 7980.321672657831, 7594.8607708843565, 7887.723929662463, 7914.6438410271385, 7956.005499312586, 7969.880451793228, 7596.886046709304, 7647.808804779869, 7671.156172820985, 7685.077790665156, 7689.154193038761, 28594.285142871388, 28655.57016644752, 29007.41985160285, 29328.0, 29581.26046848846, 3136.0, 3243.157018448996, 3262.298605799741, 3427.8971630851115, 3459.3600183965796, 15973.440929567525, 17239.74140387895, 17665.823341766547, 17776.28894844205, 18109.909450452797, 1973.0, 2042.2035406191596, 2061.165228082629, 2104.4844013216707, 2117.745870495535, 107785.0, 136991.31504342513, 139080.0, 139721.60278397187, 141062.0, 18684.719729204073, 20014.598978071394, 20725.79274207269, 20823.687644685342, 21250.78749212488, 35156.0, 35250.47124293137, 35270.8236458816, 35280.64719352774, 35334.116647084025, 10391.272610917315, 10420.0, 10598.31110977784, 10829.855818486156, 11026.44867756609, 7365.81585460357, 8801.603927823264, 8820.955895220482, 8971.693587078238, 8992.55037248135, 9489.715308540755, 9549.427034377959, 9632.229421646252, 9731.210545122523, 9807.656732014346, 2396.868172250508, 3478.652134786552, 3479.9212244204377, 3732.2722069196248, 3738.700903927679, 779.7076096463826, 848.749618862437, 911.8723378726984, 925.1257561604353, 990.2573070197352, 21172.788272117083, 21611.67582486264, 21617.243396481048, 21619.027143778254, 21689.0, 871.6513394642194, 878.5738916625431, 918.164470332008, 955.4171955107379, 959.5298303831212, 10961.397123158304, 11389.259698119597, 11411.657650270505, 11428.428578571038, 11428.885711142948, 547823.0003549563, 549512.0, 554804.0, 561887.0, 570709.0, 96667.0, 98779.0, 124743.0, 124790.0, 128460.0, 947.8009617980301, 949.349695458613, 949.8622699708503, 961.6826447272383, 971.1745016735719, 16271.430499932445, 18476.0, 18993.810061899203, 19044.904775476032, 19402.70895936534, 44368.66893993186, 52560.73719631377, 52911.73544132255, 53377.0, 53977.46022539724, 74037.25962740304, 74755.10775259086, 81220.0, 82494.0, 83605.0, 6111.877762444815, 7883.054033516015, 7979.321757650432, 8028.4781489203015, 8285.95857020711, 10303.962908931046, 13129.934350328187, 13466.259355735137, 13555.254461004739, 13585.184888906302, 11050.613228536962, 11402.36562776699, 11729.120315976164, 11734.002609777923, 11748.765024699629, 10791.6222932197, 10805.081568066802, 11297.604583839526, 11744.29534227949, 11758.470868810753, 11423.200375973935, 11645.41772911368, 11743.295402275891, 11845.644630661094, 11970.341631210367, 7999.400044996765, 8082.676692932452, 8194.34445244367, 8307.127751585997, 8340.66637334524, 8308.543030133158, 11443.656690299304, 11484.540618375171, 11745.647630571097, 11797.646070617895], "value": 10766.0509621384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.2689021038427, 1530.2654725731647, 1568.0, 1792.471220989808, 1948.6200190962768, 7793.6492857821395, 8270.297024752903, 8272.62773175207, 8281.089080201173, 8286.66853325867, 8391.748247552569, 8689.217970382664, 8691.95654021729, 8727.781805454866, 8745.518996455192, 2345.038534200982, 2378.4053986503372, 2380.3573035280465, 2380.8690522021284, 2391.378241657173, 2168.7746423270883, 2185.803277705006, 2371.5968285391436, 2371.6798232238684, 2374.1215750172373, 2336.7195936487647, 2353.964690529635, 2368.159303447277, 2373.845700029501, 2374.014783864694, 2313.421644588853, 2338.286822519131, 2342.2387723989686, 2349.236498138112, 2353.1058197884695, 2101.7477902651626, 2245.1692873636857, 2312.3294244669028, 2317.7682231776857, 2319.761430219846, 8656.307495400353, 8770.693025744069, 8772.473651580925, 8792.07683193262, 8792.560371981375, 5150.819721309774, 5169.431362550116, 5298.788048478056, 5334.333208348957, 5338.652987555796, 3504.3516949364193, 3579.83890724918, 3685.1155722626645, 3693.4829123922673, 3695.097025032084, 1027.1372047480152, 1057.5663977769077, 1061.2200032975757, 1079.6005477973122, 1083.2254937719567, 11238.831417528743, 11294.265872718248, 11420.972112509913, 11421.371824549646, 11428.799976002567, 4528.848796821483, 4589.242774942097, 4783.7129772213775, 4793.760311984456, 4807.975960120177, 9900.80198396028, 9915.950420247853, 9916.0, 9920.603175873028, 9930.070629164415, 5330.040592693274, 5333.173358129496, 5337.466253374631, 5338.3593968724, 5345.144776835766, 4122.3404255319, 4410.669199810027, 4526.185286648435, 4549.408576884984, 4880.902381952412, 3809.7714137151306, 3883.6019033148045, 3927.2145570885937, 3935.409688546684, 3949.881503554898, 1255.9560415385417, 1258.3330834657645, 1263.5135472843021, 1273.6879464531064, 1275.7320962597958, 726.596738809955, 836.197250639393, 892.5537231384308, 896.6189369517929, 934.4159900062461, 5356.250124982505, 5667.716614169358, 5836.620619659709, 5932.3177834548715, 5941.415069834342, 812.6383759227087, 905.7418635688797, 926.3098991251561, 938.2212763406357, 949.9192568631744, 3612.4220124780436, 3804.1821008483307, 3855.3060449118866, 3917.4123881418013, 3934.7442416243425, 9993.600255989824, 10445.0, 10460.32007919498, 10472.319299245524, 10501.842472362921, 10134.949325253474, 10373.740656483498, 10423.270371073952, 10439.791204175874, 10447.529861156114, 7821.335186509211, 7930.524168549906, 8109.189081091961, 8131.308838748772, 8141.185881411811, 5483.424240454695, 5535.944640553543, 5624.128260119688, 5656.6888821115235, 5675.829725108253, 9323.114304141096, 9479.431234125974, 9696.030396960248, 9821.558029888814, 9924.40453572788, 8223.588820559067, 9796.922338542898, 9907.851382229128, 10022.047905448972, 10034.899651003396, 6519.119918810899, 6572.309907459839, 6676.198856137295, 6683.298253683488, 6686.732530698718, 8044.959775201087, 8077.232662897015, 8259.297959673495, 8289.33685305162, 8311.45975511614, 7370.6683199255085, 7395.963020184865, 7476.327130558276, 7502.212267711811, 7509.699612015458, 7221.566705997657, 7310.268973102648, 7310.378617817332, 7386.2244464332625, 7408.185099638928, 6839.487038472035, 6929.445644348541, 6934.098567186234, 6934.8613027740175, 6956.756513522002, 4734.360861283821, 4865.099956508057, 4888.853334399973, 4921.237208232729, 5004.699718016931, 4852.296417019583, 4867.70793752376, 5001.524855138756, 5053.343065401621, 5090.389153301628], "value": 4502.48698741568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.56156081195763, 293.5010482180293, 297.6918888949936, 299.55216950658763, 300.8149987757527, 5177.818776342829, 5325.920111198335, 5372.892542149159, 5416.485433883775, 5448.0114758113305, 4317.0, 4508.8647340579755, 4956.0, 5120.103981803179, 5124.359455068116, 3637.3816451203224, 4043.555208927016, 4049.048473608707, 4082.7547597982602, 4106.733062350952, 3412.8293585320635, 4079.286699586181, 4092.85675001375, 4105.973506623344, 4137.751734895915, 3139.3878193752225, 3581.3374525712825, 3803.7337386382965, 3895.5520115186832, 4047.615476529725, 4030.294698427793, 4053.223541873826, 4068.593140685937, 4073.6130067643526, 4109.671226301889, 3509.9649003509894, 3515.1739341254784, 3516.49010893419, 3533.487644291589, 3556.466530020492, 4066.207089617526, 4546.613537849286, 4668.836590719308, 5134.17853143499, 5258.50044245796, 3500.9649903500895, 4193.559676234013, 4246.256905041636, 4348.652107831366, 4512.390827238313, 5200.869978250536, 5597.59303499495, 5643.209950606918, 5646.915296270559, 5651.163371904147, 3086.8919587814544, 3415.7438192135687, 3619.4751760994773, 3619.9457008144636, 3820.2359528094216, 5661.801836935729, 5847.44449277318, 5873.706314684248, 5877.148698160108, 5889.234399528077, 3653.8538458461894, 3799.2021675447913, 3806.81108362687, 3808.324337291638, 3828.578856325802, 3349.69852713257, 3357.7145942594666, 3494.021673931303, 3868.458415821787, 3899.337112690849, 4147.81334839933, 4215.946013496626, 4412.558744125626, 4568.543145685405, 4588.27939522679, 4688.718676879398, 5429.479745671219, 5651.208830763697, 5673.631213971079, 5697.521578113534, 1127.3686735428187, 1219.8655250617012, 1299.07087974358, 1314.7633425983415, 1332.4470344806796, 762.7025460070577, 821.7904434369317, 827.2596026556198, 844.3118858130604, 847.9491230526065, 4976.925346119811, 5090.516400941905, 5283.867903302448, 5294.867628309246, 5319.973400133052, 4972.5027497249985, 5404.3784964728775, 5737.934343636288, 5749.540036797046, 5758.337791153987, 5054.418741844662, 5208.817691380784, 5255.973720131451, 5256.26412302278, 5262.500062494057, 2526.3810366460334, 2638.379980704533, 2727.318170457386, 3010.4280186764445, 3014.6081009469067, 5328.254044433782, 5645.80239691617, 5706.28671416073, 5829.533637309005, 5889.263842019747, 5348.572114230852, 5604.0, 5617.21359009739, 5673.858153546112, 5844.532437405082, 5623.437656234344, 5844.327902291206, 5877.353491115974, 5880.0591905295805, 5950.880982380241, 4870.902581948412, 5054.721990290569, 5191.250006244244, 5561.332640083216, 5649.745761440663, 4821.601735496667, 5759.7408116634015, 5759.884802304015, 5769.53843692512, 5782.571320045675, 5278.9706007328205, 5779.768809247583, 5944.970275148597, 5980.760769569169, 6009.639421634716, 3304.4052070627517, 3484.285721427152, 3512.4028915083986, 3894.9221015578964, 3896.8246428911334, 5659.122835960433, 5826.359100498857, 5899.262592175978, 5902.881942361215, 5938.2280303560265, 5242.816501422432, 5363.731813409236, 5669.262995810518, 5706.400827913009, 5768.365479797135, 4717.504662010577, 5185.792568297225, 5630.183623374506, 5633.352164501135, 5677.971610141923, 4720.339152518719, 4916.0, 5276.287701160294, 5420.214068960057, 5512.704514439023, 5099.592032637306, 5529.30883639545, 5543.833684989457, 5550.222968784293, 5552.167174923794, 5543.445655434424, 5571.66570005801, 5574.9442505574425, 5590.0, 5599.188117722826], "value": 4031.01371592475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.7383741852932, 740.7703611880318, 750.0249675421957, 761.2387612387608, 789.6762327445747, 15520.534383968485, 15749.527514174593, 15753.212339383028, 15756.527304180865, 15827.129507877076, 14178.291085445739, 14257.71484570308, 14280.357383917722, 14291.0, 14333.498327558538, 717.2755516927914, 737.9926400463356, 893.3567831161586, 911.08436021798, 928.2388441477991, 924.2375040591505, 930.0978051290238, 937.1659223291276, 940.6190492850407, 942.3497786527308, 978.9314747967645, 979.6816034788723, 979.9559019844124, 980.8185485685171, 983.5819776594955, 972.3776782858976, 974.512743628186, 977.5698692575244, 978.535195782005, 981.8036392721449, 560.4115678537519, 580.274656679151, 701.5580184483742, 716.9247229040927, 726.1286456252518, 15135.318910649048, 15161.469348572857, 15176.620584485367, 15206.239688015665, 15262.694746105015, 13526.526571570046, 14052.508162214273, 14105.788413173708, 14289.142651440947, 14344.0, 12135.332556709378, 12595.937020314932, 12644.051696122735, 12647.43086561107, 12702.555410560586, 4471.6199123074575, 4562.087582483517, 4564.908701825945, 4637.0, 4667.6732628716, 110970.0, 111472.0, 111842.44078779554, 114050.92294111203, 114426.85573144245, 11007.449627518752, 11097.722556936142, 11229.157813164045, 11248.381339026268, 11259.94370028161, 22463.989120489616, 22502.774972250394, 22505.0, 22508.887455562617, 22515.88742056279, 7797.5335545539865, 8101.8379632408205, 8110.148434414419, 8188.5905704715715, 8196.385271104691, 4388.429504164438, 4412.271975124133, 4473.0, 4530.954690453053, 4608.377868987711, 3377.4933759936207, 3511.7717348372275, 3521.0669172669263, 3523.612402635708, 3524.1189702574356, 628.2649300318639, 644.9000404937242, 652.0414989964744, 654.2835595023441, 660.8810414125503, 588.7233000489763, 595.9523238140938, 611.8164550634792, 627.3444250757968, 645.5223134880155, 8450.788730281669, 8903.55482225886, 8906.643734250687, 8932.06207364257, 9055.773605659911, 592.1413949772847, 608.9817305480842, 621.2638023941644, 627.3444250757968, 636.7421194416269, 3668.724845636588, 4366.825326986948, 4378.16814805186, 4519.887002824956, 4523.2054022736, 145891.2705436466, 149082.0, 149813.0, 150909.0, 157212.0, 103062.48468757758, 103311.9999999985, 104069.0, 122060.0, 124209.0, 97760.51119744356, 97868.0, 99695.50152249192, 101953.0, 102343.23052849018, 8278.917210827814, 9730.318877678494, 9896.0, 9952.900470995197, 9964.10323070927, 58123.700207966525, 58484.70757646184, 58792.0, 60004.69997649984, 60125.09812352906, 81443.5566932993, 85583.71624425764, 88714.55642721745, 90230.0, 91607.54196228976, 12524.330960960326, 12945.352732363532, 13030.348482575644, 13383.263920484467, 13749.800031994833, 14238.790771043134, 14259.42962281497, 14661.669046485647, 14738.778918316018, 14794.77807832905, 13398.799018014543, 13429.932850335686, 13449.125806822525, 13498.214232418615, 13784.655383615489, 13454.663633409244, 13619.863801362257, 13695.589132326046, 13735.656608584466, 14116.0, 13251.734965300833, 13394.93302533481, 13411.329433528479, 13422.328883555978, 13441.932790335986, 10927.83608245861, 11058.889411106107, 11436.428178591204, 11633.389415799293, 11634.70913227176, 10822.458877056273, 11255.911770715675, 11305.604303849326, 11339.206255562032, 11404.714882128013], "value": 7860.36834291127, "unit": "score"}], "name": "dromaeo_css", "value": 7379.897298842096, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 120.0, 163.0, 157.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 122.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 103.0, 165.0, 139.0, 138.0, 99.0, 133.0, 173.0, 141.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 183.0, 185.0, 184.0, 189.0, 182.0, 183.0, 180.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 69.0, 57.0, 88.0, 58.0, 75.0, 82.0, 82.0, 96.0, 57.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 89.0, 69.0, 68.0, 68.0, 91.0, 66.0, 68.0, 94.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 88.0, 85.0, 87.0, 86.0, 89.0, 87.0, 89.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 79.0, 81.0, 84.0, 83.0, 87.0, 86.0, 85.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 56.0, 56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 82.0, 75.0, 72.0, 70.0, 68.0, 70.0, 71.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 84.0, 85.0, 85.0, 89.0, 83.0, 88.0, 85.0, 99.0, 105.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 148.0, 146.0, 121.0, 144.0, 154.0, 205.0, 148.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 173.0, 171.0, 171.0, 171.0, 172.0, 171.0, 169.0, 171.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 86.0, 85.0, 83.0, 79.0, 71.0, 68.0, 66.0, 69.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1474.7, "alertThreshold": 2.0}]} 06:40:17 INFO - Return code: 0 06:40:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:40:17 INFO - # TBPL SUCCESS # 06:40:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:40:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:40:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:40:17 INFO - 2016-10-20 06:40:17.485 screenresolution[1675:9921] starting screenresolution argv=screenresolution get 06:40:17 INFO - 2016-10-20 06:40:17.488 screenresolution[1675:9921] Display 0: 1600x1200x32@60 06:40:17 INFO - 2016-10-20 06:40:17.493 screenresolution[1676:9924] starting screenresolution argv=screenresolution list 06:40:17 INFO - Available Modes on Display 0 06:40:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:40:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:40:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:40:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:40:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:40:17 INFO - Intel Iris: 06:40:17 INFO - Chipset Model: Intel Iris 06:40:17 INFO - Type: GPU 06:40:17 INFO - Bus: Built-In 06:40:17 INFO - VRAM (Dynamic, Max): 1536 MB 06:40:17 INFO - Vendor: Intel (0x8086) 06:40:17 INFO - Device ID: 0x0a2e 06:40:17 INFO - Revision ID: 0x0009 06:40:17 INFO - Displays: 06:40:17 INFO - Display: 06:40:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:40:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:40:17 INFO - Display Serial Number: 1600x1200 60 06:40:17 INFO - Main Display: Yes 06:40:17 INFO - Mirror: Off 06:40:17 INFO - Online: Yes 06:40:17 INFO - Rotation: Supported 06:40:17 INFO - Return code: 0 06:40:17 INFO - Running post-action listener: _resource_record_post_action 06:40:17 INFO - [mozharness: 2016-10-20 13:40:17.730104Z] Finished run-tests step (success) 06:40:17 INFO - Running post-run listener: _resource_record_post_run 06:40:17 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37270528; Write bytes: 708238336; Read time: 245; Write time: 1964 06:40:17 INFO - TinderboxPrint: CPU usage
53.9% 06:40:17 INFO - TinderboxPrint: I/O read bytes / time
37,270,528 / 245 06:40:17 INFO - TinderboxPrint: I/O write bytes / time
708,238,336 / 1,964 06:40:17 INFO - TinderboxPrint: CPU idle
2,240.9 (46.1%) 06:40:17 INFO - TinderboxPrint: CPU system
975.9 (20.1%) 06:40:17 INFO - TinderboxPrint: CPU user
1,640.9 (33.8%) 06:40:17 INFO - TinderboxPrint: Swap in / out
443,555,840 / 0 06:40:17 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401942016; Write bytes: 392796160; Read time: 29475; Write time: 804 06:40:17 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29977600; Write bytes: 299140096; Read time: 180; Write time: 1113 06:40:18 INFO - Running post-run listener: _upload_blobber_files 06:40:18 INFO - Blob upload gear active. 06:40:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:40:18 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 06:40:18 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'] 06:40:18 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 06:40:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:19 INFO - (blobuploader) - INFO - Done attempting. 06:40:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:40:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:40:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:20 INFO - (blobuploader) - INFO - Done attempting. 06:40:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:40:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:40:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:22 INFO - (blobuploader) - INFO - Done attempting. 06:40:22 INFO - (blobuploader) - INFO - Iteration through files over. 06:40:22 INFO - Return code: 0 06:40:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:40:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:40:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c80d2a4b92b2ab8b9d35ef2e705d55c37177bddae806c6179a6ae65879afeef5df637c7221a0c5d1d44828f9a66b7d078ea2d08c4ba2b37069e7ba2ce9481301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2701ecc968b25207da61f035ad6abc7ec1dec795790b24b83084099621f39fc54e361110f0bdb5d1c159830fb1641b08f1fde985a1239badf79b20aea0e0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fc4b355daa5939fc7b552cde9035561b6b4b5377da5871ccf54e5af4ba74c03f8ffedf9a6b38882526d1a2cb8033c57f32144d5ff65053fd5a927e99017024"} 06:40:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:40:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:40:22 INFO - Contents: 06:40:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c80d2a4b92b2ab8b9d35ef2e705d55c37177bddae806c6179a6ae65879afeef5df637c7221a0c5d1d44828f9a66b7d078ea2d08c4ba2b37069e7ba2ce9481301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2701ecc968b25207da61f035ad6abc7ec1dec795790b24b83084099621f39fc54e361110f0bdb5d1c159830fb1641b08f1fde985a1239badf79b20aea0e0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fc4b355daa5939fc7b552cde9035561b6b4b5377da5871ccf54e5af4ba74c03f8ffedf9a6b38882526d1a2cb8033c57f32144d5ff65053fd5a927e99017024"} 06:40:22 INFO - Running post-run listener: copy_logs_to_upload_dir 06:40:22 INFO - Copying logs to upload dir... 06:40:22 INFO - mkdir: /builds/slave/test/build/upload/logs 06:40:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.978203 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-20 06:40:23.040375) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 06:40:23.043956) ========= 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.jxNOA3itiM/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.P0q7eInzDt/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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/c80d2a4b92b2ab8b9d35ef2e705d55c37177bddae806c6179a6ae65879afeef5df637c7221a0c5d1d44828f9a66b7d078ea2d08c4ba2b37069e7ba2ce9481301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2701ecc968b25207da61f035ad6abc7ec1dec795790b24b83084099621f39fc54e361110f0bdb5d1c159830fb1641b08f1fde985a1239badf79b20aea0e0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fc4b355daa5939fc7b552cde9035561b6b4b5377da5871ccf54e5af4ba74c03f8ffedf9a6b38882526d1a2cb8033c57f32144d5ff65053fd5a927e99017024"} build_url:https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011076 build_url: 'https://queue.taskcluster.net/v1/task/bdLFdQw-Rz-tBI9wzK3msw/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/c80d2a4b92b2ab8b9d35ef2e705d55c37177bddae806c6179a6ae65879afeef5df637c7221a0c5d1d44828f9a66b7d078ea2d08c4ba2b37069e7ba2ce9481301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2701ecc968b25207da61f035ad6abc7ec1dec795790b24b83084099621f39fc54e361110f0bdb5d1c159830fb1641b08f1fde985a1239badf79b20aea0e0917", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fc4b355daa5939fc7b552cde9035561b6b4b5377da5871ccf54e5af4ba74c03f8ffedf9a6b38882526d1a2cb8033c57f32144d5ff65053fd5a927e99017024"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 06:40:23.076121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:40:23.076455) ========= 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.jxNOA3itiM/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.P0q7eInzDt/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.005271 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:40:23.125335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 06:40:23.125715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 06:40:23.126230) ========= ========= Total master_lag: 2.01 =========