builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0174 starttime: 1475768834.97 results: success (0) buildid: 20161006063200 builduid: 0840c51dfe0045b99eb2732eff2f347f revision: fdda673f01a75e908a3fd50d2975931a2c753381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:14.967919) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:14.968335) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:14.968617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:14.992802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:14.993099) ========= 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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-06 08:47:15-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 4.67M=0.002s 2016-10-06 08:47:15 (4.67 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:15.148142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:15.148454) ========= 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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.028955 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:15.196945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 08:47:15.197287) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fdda673f01a75e908a3fd50d2975931a2c753381 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fdda673f01a75e908a3fd50d2975931a2c753381 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gVUUMGhnJO/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.jTfYWnEpcw/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-06 08:47:15,266 truncating revision to first 12 chars 2016-10-06 08:47:15,266 Setting DEBUG logging. 2016-10-06 08:47:15,266 attempt 1/10 2016-10-06 08:47:15,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fdda673f01a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 08:47:16,213 unpacking tar archive at: fx-team-fdda673f01a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 08:47:16.427777) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:16.428107) ========= script_repo_revision: fdda673f01a75e908a3fd50d2975931a2c753381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:16.428484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:16.428753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 08:47:16.447619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-06 08:47:16.447912) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gVUUMGhnJO/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.jTfYWnEpcw/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:16 INFO - MultiFileLogger online at 20161006 08:47:16 in /builds/slave/test 08:47:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:47:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:16 INFO - {'append_to_log': False, 08:47:16 INFO - 'base_work_dir': '/builds/slave/test', 08:47:16 INFO - 'blob_upload_branch': 'Fx-Team', 08:47:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:16 INFO - 'branch': 'Fx-Team', 08:47:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:16 INFO - 'config_files': ('talos/mac_config.py',), 08:47:16 INFO - 'default_actions': ('clobber', 08:47:16 INFO - 'read-buildbot-config', 08:47:16 INFO - 'download-and-extract', 08:47:16 INFO - 'populate-webroot', 08:47:16 INFO - 'create-virtualenv', 08:47:16 INFO - 'install', 08:47:16 INFO - 'run-tests'), 08:47:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:16 INFO - 'download_minidump_stackwalk': True, 08:47:16 INFO - 'download_symbols': 'ondemand', 08:47:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:16 INFO - 'installer_path': 'installer.exe', 08:47:16 INFO - 'log_level': 'info', 08:47:16 INFO - 'log_name': 'talos', 08:47:16 INFO - 'log_to_console': True, 08:47:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:47:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:47:16 INFO - 'opt_config_files': (), 08:47:16 INFO - 'pip_index': False, 08:47:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:16 INFO - 'cmd': ('bash', 08:47:16 INFO - '-c', 08:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:16 INFO - 'enabled': True, 08:47:16 INFO - 'halt_on_failure': False, 08:47:16 INFO - 'name': 'check_screen_resolution'},), 08:47:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:47:16 INFO - 'cmd': ('bash', 08:47:16 INFO - '-c', 08:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:47:16 INFO - 'enabled': True, 08:47:16 INFO - 'halt_on_failure': False, 08:47:16 INFO - 'name': 'check_screen_resolution'},), 08:47:16 INFO - 'run_cmd_checks_enabled': True, 08:47:16 INFO - 'sps_profile': False, 08:47:16 INFO - 'sps_profile_interval': 0, 08:47:16 INFO - 'suite': 'dromaeojs', 08:47:16 INFO - 'system_bits': '32', 08:47:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:16 INFO - 'title': 't-yosemite-r7-0174', 08:47:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:16 INFO - 'use_talos_json': True, 08:47:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:16 INFO - 'work_dir': 'build'} 08:47:16 INFO - [mozharness: 2016-10-06 15:47:16.663235Z] Running clobber step. 08:47:16 INFO - Running pre-action listener: _resource_record_pre_action 08:47:16 INFO - Running main action method: clobber 08:47:16 INFO - rmtree: /builds/slave/test/build 08:47:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:18 INFO - Running post-action listener: _resource_record_post_action 08:47:18 INFO - [mozharness: 2016-10-06 15:47:18.951290Z] Finished clobber step (success) 08:47:18 INFO - [mozharness: 2016-10-06 15:47:18.951411Z] Running read-buildbot-config step. 08:47:18 INFO - Running pre-action listener: _resource_record_pre_action 08:47:18 INFO - Running main action method: read_buildbot_config 08:47:18 INFO - Using buildbot properties: 08:47:18 INFO - { 08:47:18 INFO - "project": "", 08:47:18 INFO - "product": "firefox", 08:47:18 INFO - "script_repo_revision": "production", 08:47:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:47:18 INFO - "repository": "", 08:47:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:47:18 INFO - "buildid": "20161006063200", 08:47:18 INFO - "pgo_build": "False", 08:47:18 INFO - "basedir": "/builds/slave/test", 08:47:18 INFO - "buildnumber": 167, 08:47:18 INFO - "slavename": "t-yosemite-r7-0174", 08:47:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:47:18 INFO - "platform": "yosemite_r7", 08:47:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:47:18 INFO - "branch": "fx-team", 08:47:18 INFO - "repo_path": "integration/fx-team", 08:47:18 INFO - "revision": "fdda673f01a75e908a3fd50d2975931a2c753381", 08:47:18 INFO - "stage_platform": "macosx64", 08:47:18 INFO - "builduid": "0840c51dfe0045b99eb2732eff2f347f", 08:47:18 INFO - "slavebuilddir": "test" 08:47:18 INFO - } 08:47:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:47:18 INFO - Running post-action listener: _resource_record_post_action 08:47:18 INFO - [mozharness: 2016-10-06 15:47:18.954755Z] Finished read-buildbot-config step (success) 08:47:18 INFO - [mozharness: 2016-10-06 15:47:18.954872Z] Running download-and-extract step. 08:47:18 INFO - Running pre-action listener: _resource_record_pre_action 08:47:18 INFO - Running main action method: download_and_extract 08:47:18 INFO - mkdir: /builds/slave/test/build/tests 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:18 INFO - trying https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:47:18 INFO - Downloading https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/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 08:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/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 08:47:20 INFO - Downloaded 1199 bytes. 08:47:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:47:20 INFO - Using the following test package requirements: 08:47:20 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:47:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:47:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:47:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'jsshell-mac.zip'], 08:47:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:47:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:47:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:47:20 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:47:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:47:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:47:20 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:47:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:47:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:47:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:47:20 INFO - Fetch https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:47:20 INFO - Http code: 200 08:47:20 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 08:47:20 INFO - x-amz-cf-id: 1ZWeniuWclIvog_1kEFm5ml1A3pSYLQShmNGjKYe09HYVcjZDA5FnA== 08:47:20 INFO - x-amz-version-id: SOPPbynSbikp0IRGksIuHq0sr6G9WAk. 08:47:21 INFO - Expected file size: 16478317 08:47:21 INFO - Obtained file size: 16478317 08:47:27 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 08:47:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:47:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:47:27 INFO - Fetch https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:47:28 INFO - Http code: 200 08:47:28 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 08:47:28 INFO - x-amz-cf-id: L_1YwU_toVMsqU8Pa9cqac0rX-EBS44B3xkX3f2eFnabi49KeuZgkw== 08:47:28 INFO - x-amz-version-id: SOPPbynSbikp0IRGksIuHq0sr6G9WAk. 08:47:28 INFO - Expected file size: 16478317 08:47:28 INFO - Obtained file size: 16478317 08:47:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:47:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:47:35 INFO - Fetch https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:47:35 INFO - Http code: 200 08:47:35 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 08:47:35 INFO - x-amz-cf-id: QkapKGGUinNzfAblQJyPHmt4n8ed02NGQm3HGy5G1X4iguI9-leXgw== 08:47:35 INFO - x-amz-version-id: n2YSqAzc.ZT9ffmf4WWxLpAnlUzpLLD1 08:47:35 INFO - Expected file size: 14409006 08:47:35 INFO - Obtained file size: 14409006 08:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:36 INFO - trying https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:47:36 INFO - Downloading https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/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 08:47:39 INFO - Downloaded 111660532 bytes. 08:47:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:47:39 INFO - mkdir: /builds/slave/test/properties 08:47:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:39 INFO - Contents: 08:47:39 INFO - build_url:https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:47:39 INFO - Running post-action listener: _resource_record_post_action 08:47:39 INFO - Running post-action listener: set_extra_try_arguments 08:47:39 INFO - [mozharness: 2016-10-06 15:47:39.744338Z] Finished download-and-extract step (success) 08:47:39 INFO - [mozharness: 2016-10-06 15:47:39.744472Z] Running populate-webroot step. 08:47:39 INFO - Running pre-action listener: _resource_record_pre_action 08:47:39 INFO - Running main action method: populate_webroot 08:47:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:39 INFO - '--tppagecycles', 08:47:39 INFO - '7'], 08:47:39 INFO - 'tests': ['tsvgm']}}, 08:47:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:47:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:47:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['damp', 'tps']}, 08:47:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'tests': ['damp', 'tps']}, 08:47:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['dromaeo_dom']}, 08:47:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['basic_compositor_video']}, 08:47:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:47:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['a11yr', 08:47:39 INFO - 'ts_paint', 08:47:39 INFO - 'tpaint', 08:47:39 INFO - 'sessionrestore', 08:47:39 INFO - 'sessionrestore_no_auto_restore', 08:47:39 INFO - 'tabpaint']}, 08:47:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:47:39 INFO - 'ts_paint', 08:47:39 INFO - 'tpaint', 08:47:39 INFO - 'sessionrestore', 08:47:39 INFO - 'sessionrestore_no_auto_restore', 08:47:39 INFO - 'tabpaint']}, 08:47:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:47:39 INFO - 'ts_paint', 08:47:39 INFO - 'tpaint', 08:47:39 INFO - 'sessionrestore', 08:47:39 INFO - 'sessionrestore_no_auto_restore', 08:47:39 INFO - 'tabpaint']}, 08:47:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:47:39 INFO - 'ts_paint', 08:47:39 INFO - 'tpaint', 08:47:39 INFO - 'sessionrestore', 08:47:39 INFO - 'sessionrestore_no_auto_restore', 08:47:39 INFO - 'tabpaint']}, 08:47:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['a11yr', 08:47:39 INFO - 'ts_paint', 08:47:39 INFO - 'tpaint', 08:47:39 INFO - 'sessionrestore', 08:47:39 INFO - 'sessionrestore_no_auto_restore', 08:47:39 INFO - 'tabpaint']}, 08:47:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['a11yr', 08:47:39 INFO - 'ts_paint', 08:47:39 INFO - 'tpaint', 08:47:39 INFO - 'sessionrestore', 08:47:39 INFO - 'sessionrestore_no_auto_restore', 08:47:39 INFO - 'tabpaint']}, 08:47:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['tsvgx', 08:47:39 INFO - 'tsvgr_opacity', 08:47:39 INFO - 'tart', 08:47:39 INFO - 'tscrollx', 08:47:39 INFO - 'cart']}, 08:47:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:47:39 INFO - 'tsvgr_opacity', 08:47:39 INFO - 'tart', 08:47:39 INFO - 'tscrollx', 08:47:39 INFO - 'cart']}, 08:47:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'talos_options': ['--disable-e10s'], 08:47:39 INFO - 'tests': ['tp5o']}, 08:47:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'tests': ['tp5o']}, 08:47:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'talos_options': ['--disable-e10s', 08:47:39 INFO - '--xperf_path', 08:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:39 INFO - 'tests': ['tp5n']}, 08:47:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:39 INFO - 'talos_options': ['--xperf_path', 08:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:39 INFO - 'tests': ['tp5n']}}, 08:47:39 INFO - 'talos.zip': {'path': '', 08:47:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:39 INFO - Running post-action listener: _resource_record_post_action 08:47:39 INFO - [mozharness: 2016-10-06 15:47:39.763333Z] Finished populate-webroot step (success) 08:47:39 INFO - [mozharness: 2016-10-06 15:47:39.763428Z] Running create-virtualenv step. 08:47:39 INFO - Running pre-action listener: _resource_record_pre_action 08:47:39 INFO - Running main action method: create_virtualenv 08:47:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:39 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 08:47:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:39 INFO - Using real prefix '/tools/python27' 08:47:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:43 INFO - Installing pip.................done. 08:47:43 INFO - Return code: 0 08:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:47:43 INFO - Reading from file tmpfile_stdout 08:47:43 INFO - Output received: 08:47:43 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) 08:47:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:43 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')]} 08:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:43 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')]} 08:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:43 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:43 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 08:47:43 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 08:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:43 INFO - 'HOME': '/Users/cltbld', 08:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:43 INFO - 'LOGNAME': 'cltbld', 08:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:43 INFO - 'MOZ_NO_REMOTE': '1', 08:47:43 INFO - 'NO_EM_RESTART': '1', 08:47:43 INFO - 'PAGER': '/bin/cat', 08:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:43 INFO - 'PWD': '/builds/slave/test', 08:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:43 INFO - 'SHELL': '/bin/bash', 08:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:47:43 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:43 INFO - 'USER': 'cltbld', 08:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:43 INFO - 'XPC_FLAGS': '0x0', 08:47:43 INFO - 'XPC_SERVICE_NAME': '0', 08:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:44 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 08:47:44 INFO - Cleaning up... 08:47:44 INFO - Return code: 0 08:47:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:47:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:44 INFO - 'HOME': '/Users/cltbld', 08:47:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:44 INFO - 'LOGNAME': 'cltbld', 08:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:44 INFO - 'MOZ_NO_REMOTE': '1', 08:47:44 INFO - 'NO_EM_RESTART': '1', 08:47:44 INFO - 'PAGER': '/bin/cat', 08:47:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:44 INFO - 'PWD': '/builds/slave/test', 08:47:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:44 INFO - 'SHELL': '/bin/bash', 08:47:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:47:44 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:47:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:44 INFO - 'USER': 'cltbld', 08:47:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:44 INFO - 'XPC_FLAGS': '0x0', 08:47:44 INFO - 'XPC_SERVICE_NAME': '0', 08:47:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:44 INFO - Downloading/unpacking psutil>=3.1.1 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:47 INFO - Installing collected packages: psutil 08:47:47 INFO - Running setup.py install for psutil 08:47:47 INFO - building 'psutil._psutil_osx' extension 08:47:47 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 08:47:48 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 08:47:48 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 08:47:48 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 08:47:48 INFO - building 'psutil._psutil_posix' extension 08:47:48 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 08:47:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:47:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:47:48 INFO - ^ 08:47:48 INFO - 1 warning generated. 08:47:48 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 08:47:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:48 INFO - Successfully installed psutil 08:47:48 INFO - Cleaning up... 08:47:49 INFO - Return code: 0 08:47:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:47:49 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')]} 08:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:49 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')]} 08:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:49 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:49 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 08:47:49 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 08:47:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:47:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:49 INFO - 'HOME': '/Users/cltbld', 08:47:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:49 INFO - 'LOGNAME': 'cltbld', 08:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:49 INFO - 'MOZ_NO_REMOTE': '1', 08:47:49 INFO - 'NO_EM_RESTART': '1', 08:47:49 INFO - 'PAGER': '/bin/cat', 08:47:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:49 INFO - 'PWD': '/builds/slave/test', 08:47:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:49 INFO - 'SHELL': '/bin/bash', 08:47:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:47:49 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:47:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:49 INFO - 'USER': 'cltbld', 08:47:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:49 INFO - 'XPC_FLAGS': '0x0', 08:47:49 INFO - 'XPC_SERVICE_NAME': '0', 08:47:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:47:51 INFO - Installing collected packages: mozsystemmonitor 08:47:51 INFO - Running setup.py install for mozsystemmonitor 08:47:52 INFO - Successfully installed mozsystemmonitor 08:47:52 INFO - Cleaning up... 08:47:52 INFO - Return code: 0 08:47:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:47:52 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')]} 08:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:52 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')]} 08:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:52 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:52 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 08:47:52 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 08:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:52 INFO - 'HOME': '/Users/cltbld', 08:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:52 INFO - 'LOGNAME': 'cltbld', 08:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:52 INFO - 'MOZ_NO_REMOTE': '1', 08:47:52 INFO - 'NO_EM_RESTART': '1', 08:47:52 INFO - 'PAGER': '/bin/cat', 08:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:52 INFO - 'PWD': '/builds/slave/test', 08:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:52 INFO - 'SHELL': '/bin/bash', 08:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:47:52 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:52 INFO - 'USER': 'cltbld', 08:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:52 INFO - 'XPC_FLAGS': '0x0', 08:47:52 INFO - 'XPC_SERVICE_NAME': '0', 08:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:52 INFO - Downloading/unpacking jsonschema==2.5.1 08:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:55 INFO - warning: no files found matching '*.txt' 08:47:55 INFO - no previously-included directories found matching 'build' 08:47:55 INFO - no previously-included directories found matching 'dist' 08:47:55 INFO - no previously-included directories found matching '.git*' 08:47:55 INFO - Installing collected packages: jsonschema, functools32 08:47:55 INFO - Running setup.py install for functools32 08:47:55 INFO - warning: no files found matching '*.txt' 08:47:55 INFO - no previously-included directories found matching 'build' 08:47:55 INFO - no previously-included directories found matching 'dist' 08:47:55 INFO - no previously-included directories found matching '.git*' 08:47:55 INFO - Successfully installed jsonschema functools32 08:47:55 INFO - Cleaning up... 08:47:55 INFO - Return code: 0 08:47:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:55 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:55 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 08:47:55 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 08:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:55 INFO - 'HOME': '/Users/cltbld', 08:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:55 INFO - 'LOGNAME': 'cltbld', 08:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:55 INFO - 'MOZ_NO_REMOTE': '1', 08:47:55 INFO - 'NO_EM_RESTART': '1', 08:47:55 INFO - 'PAGER': '/bin/cat', 08:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:55 INFO - 'PWD': '/builds/slave/test', 08:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:55 INFO - 'SHELL': '/bin/bash', 08:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:47:55 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:55 INFO - 'USER': 'cltbld', 08:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:55 INFO - 'XPC_FLAGS': '0x0', 08:47:55 INFO - 'XPC_SERVICE_NAME': '0', 08:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:47:55 INFO - Cleaning up... 08:47:55 INFO - Return code: 0 08:47:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:55 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:47:55 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 08:47:55 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 08:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:55 INFO - 'HOME': '/Users/cltbld', 08:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:55 INFO - 'LOGNAME': 'cltbld', 08:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:55 INFO - 'MOZ_NO_REMOTE': '1', 08:47:55 INFO - 'NO_EM_RESTART': '1', 08:47:55 INFO - 'PAGER': '/bin/cat', 08:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:55 INFO - 'PWD': '/builds/slave/test', 08:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:55 INFO - 'SHELL': '/bin/bash', 08:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:47:55 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:55 INFO - 'USER': 'cltbld', 08:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:55 INFO - 'XPC_FLAGS': '0x0', 08:47:55 INFO - 'XPC_SERVICE_NAME': '0', 08:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:56 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 08:47:56 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 08:47:56 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 08:47:56 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 08:47:56 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 08:47:56 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 08:47:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:58 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 08:47:58 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 08:47:58 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 08:47:58 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 08:47:58 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 08:47:58 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 08:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 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 08:47:59 INFO - Downloading docopt-0.6.1.tar.gz 08:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:59 INFO - Running setup.py install for blobuploader 08:48:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:00 INFO - Running setup.py install for requests 08:48:00 INFO - Running setup.py install for docopt 08:48:00 INFO - Successfully installed blobuploader requests docopt 08:48:00 INFO - Cleaning up... 08:48:00 INFO - Return code: 0 08:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:00 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:48:00 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 08:48:00 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 08:48:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:48:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:00 INFO - 'HOME': '/Users/cltbld', 08:48:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:00 INFO - 'LOGNAME': 'cltbld', 08:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:00 INFO - 'MOZ_NO_REMOTE': '1', 08:48:00 INFO - 'NO_EM_RESTART': '1', 08:48:00 INFO - 'PAGER': '/bin/cat', 08:48:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:00 INFO - 'PWD': '/builds/slave/test', 08:48:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:00 INFO - 'SHELL': '/bin/bash', 08:48:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:48:00 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:48:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:00 INFO - 'USER': 'cltbld', 08:48:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:00 INFO - 'XPC_FLAGS': '0x0', 08:48:00 INFO - 'XPC_SERVICE_NAME': '0', 08:48:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-o6sovi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-KWEOa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-R58KYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-b5awrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1uhVH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-7NcB6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-sx2GTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-NsgEfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:01 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-be5VSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-TAmOWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-FxKJgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ci5p7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-cXabbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-JBAdeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-UndY7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-hwLBHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:02 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-4OgmmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:02 INFO - Running setup.py install for manifestparser 08:48:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:02 INFO - Running setup.py install for mozcrash 08:48:03 INFO - Running setup.py install for mozdebug 08:48:03 INFO - Running setup.py install for mozdevice 08:48:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:03 INFO - Running setup.py install for mozfile 08:48:03 INFO - Running setup.py install for mozhttpd 08:48:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:03 INFO - Running setup.py install for mozinfo 08:48:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:03 INFO - Running setup.py install for mozInstall 08:48:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozleak 08:48:04 INFO - Running setup.py install for mozlog 08:48:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for moznetwork 08:48:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozprocess 08:48:04 INFO - Running setup.py install for mozprofile 08:48:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:04 INFO - Running setup.py install for mozrunner 08:48:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Running setup.py install for mozscreenshot 08:48:05 INFO - Running setup.py install for moztest 08:48:05 INFO - Running setup.py install for mozversion 08:48:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:05 INFO - Cleaning up... 08:48:05 INFO - Return code: 0 08:48:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:05 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')]} 08:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:05 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')]} 08:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:05 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:48:05 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 08:48:05 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 08:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:05 INFO - 'HOME': '/Users/cltbld', 08:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:05 INFO - 'LOGNAME': 'cltbld', 08:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:05 INFO - 'MOZ_NO_REMOTE': '1', 08:48:05 INFO - 'NO_EM_RESTART': '1', 08:48:05 INFO - 'PAGER': '/bin/cat', 08:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:05 INFO - 'PWD': '/builds/slave/test', 08:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:05 INFO - 'SHELL': '/bin/bash', 08:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:48:05 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:05 INFO - 'USER': 'cltbld', 08:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:05 INFO - 'XPC_FLAGS': '0x0', 08:48:05 INFO - 'XPC_SERVICE_NAME': '0', 08:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-V00ApV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:05 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)) 08:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Sdw2YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:05 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)) 08:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-31MW7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-0g2XNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1WTkFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-jGYn_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-StioHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-G2DLa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-4aS0gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Hm5_3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Qr_4HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:06 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)) 08:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:06 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-jLGXJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-7Dov5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-EigB46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_jxB2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-QGPMRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:07 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)) 08:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:07 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-WDsIQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 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)) 08:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:07 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 08:48:09 INFO - Downloading blessings-1.6.tar.gz 08:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:10 INFO - Installing collected packages: blessings 08:48:10 INFO - Running setup.py install for blessings 08:48:10 INFO - Successfully installed blessings 08:48:10 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:10 INFO - Reading from file tmpfile_stdout 08:48:10 INFO - Current package versions: 08:48:10 INFO - blessings == 1.6 08:48:10 INFO - blobuploader == 1.2.4 08:48:10 INFO - docopt == 0.6.1 08:48:10 INFO - functools32 == 3.2.3-2 08:48:10 INFO - jsonschema == 2.5.1 08:48:10 INFO - manifestparser == 1.1 08:48:10 INFO - mozInstall == 1.12 08:48:10 INFO - mozcrash == 0.17 08:48:10 INFO - mozdebug == 0.1 08:48:10 INFO - mozdevice == 0.48 08:48:10 INFO - mozfile == 1.2 08:48:10 INFO - mozhttpd == 0.7 08:48:10 INFO - mozinfo == 0.9 08:48:10 INFO - mozleak == 0.1 08:48:10 INFO - mozlog == 3.4 08:48:10 INFO - moznetwork == 0.27 08:48:10 INFO - mozprocess == 0.23 08:48:10 INFO - mozprofile == 0.28 08:48:10 INFO - mozrunner == 6.12 08:48:10 INFO - mozscreenshot == 0.1 08:48:10 INFO - mozsystemmonitor == 0.3 08:48:10 INFO - moztest == 0.7 08:48:10 INFO - mozversion == 1.4 08:48:10 INFO - psutil == 3.1.1 08:48:10 INFO - requests == 1.2.3 08:48:10 INFO - wsgiref == 0.1.2 08:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 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')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:48:11 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 08:48:11 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 08:48:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:48:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:11 INFO - 'HOME': '/Users/cltbld', 08:48:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:11 INFO - 'LOGNAME': 'cltbld', 08:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:11 INFO - 'MOZ_NO_REMOTE': '1', 08:48:11 INFO - 'NO_EM_RESTART': '1', 08:48:11 INFO - 'PAGER': '/bin/cat', 08:48:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:11 INFO - 'PWD': '/builds/slave/test', 08:48:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:11 INFO - 'SHELL': '/bin/bash', 08:48:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:48:11 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:48:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:11 INFO - 'USER': 'cltbld', 08:48:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:11 INFO - 'XPC_FLAGS': '0x0', 08:48:11 INFO - 'XPC_SERVICE_NAME': '0', 08:48:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 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)) 08:48:11 INFO - Cleaning up... 08:48:11 INFO - Return code: 0 08:48:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:11 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')]} 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 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')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:12 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 0x1096e0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109656570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9d2da4280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, '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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 08:48:12 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 08:48:12 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 08:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:12 INFO - 'HOME': '/Users/cltbld', 08:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:12 INFO - 'LOGNAME': 'cltbld', 08:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:12 INFO - 'MOZ_NO_REMOTE': '1', 08:48:12 INFO - 'NO_EM_RESTART': '1', 08:48:12 INFO - 'PAGER': '/bin/cat', 08:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:12 INFO - 'PWD': '/builds/slave/test', 08:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:12 INFO - 'SHELL': '/bin/bash', 08:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:48:12 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:12 INFO - 'USER': 'cltbld', 08:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:12 INFO - 'XPC_FLAGS': '0x0', 08:48:12 INFO - 'XPC_SERVICE_NAME': '0', 08:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:12 INFO - Cleaning up... 08:48:12 INFO - Return code: 0 08:48:12 INFO - Running post-action listener: _resource_record_post_action 08:48:12 INFO - Running post-action listener: _start_resource_monitoring 08:48:12 INFO - Starting resource monitoring. 08:48:12 INFO - [mozharness: 2016-10-06 15:48:12.613069Z] Finished create-virtualenv step (success) 08:48:12 INFO - [mozharness: 2016-10-06 15:48:12.614133Z] Running install step. 08:48:12 INFO - Running pre-action listener: _resource_record_pre_action 08:48:12 INFO - Running main action method: install 08:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:12 INFO - Reading from file tmpfile_stdout 08:48:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:12 INFO - Reading from file tmpfile_stdout 08:48:12 INFO - Output received: 08:48:12 INFO - Usage: mozinstall [options] installer 08:48:12 INFO - Options: 08:48:12 INFO - -h, --help show this help message and exit 08:48:12 INFO - -d DEST, --destination=DEST 08:48:12 INFO - Directory to install application into. [default: 08:48:12 INFO - "/builds/slave/test"] 08:48:12 INFO - --app=APP Application being installed. [default: firefox] 08:48:12 INFO - mkdir: /builds/slave/test/build/application 08:48:12 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'] 08:48:12 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 08:48:46 INFO - Reading from file tmpfile_stdout 08:48:46 INFO - Output received: 08:48:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:48:46 INFO - Running post-action listener: _resource_record_post_action 08:48:46 INFO - [mozharness: 2016-10-06 15:48:46.986140Z] Finished install step (success) 08:48:46 INFO - [mozharness: 2016-10-06 15:48:46.986281Z] Running run-tests step. 08:48:46 INFO - Running pre-action listener: _resource_record_pre_action 08:48:46 INFO - Running main action method: run_tests 08:48:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:47 INFO - 2016-10-06 08:48:47.000 screenresolution[1641:7964] starting screenresolution argv=screenresolution get 08:48:47 INFO - 2016-10-06 08:48:47.003 screenresolution[1641:7964] Display 0: 1600x1200x32@60 08:48:47 INFO - 2016-10-06 08:48:47.009 screenresolution[1642:7966] starting screenresolution argv=screenresolution list 08:48:47 INFO - Available Modes on Display 0 08:48:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:47 INFO - Intel Iris: 08:48:47 INFO - Chipset Model: Intel Iris 08:48:47 INFO - Type: GPU 08:48:47 INFO - Bus: Built-In 08:48:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:47 INFO - Vendor: Intel (0x8086) 08:48:47 INFO - Device ID: 0x0a2e 08:48:47 INFO - Revision ID: 0x0009 08:48:47 INFO - Displays: 08:48:47 INFO - Display: 08:48:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:47 INFO - Display Serial Number: 1600x1200 60 08:48:47 INFO - Main Display: Yes 08:48:47 INFO - Mirror: Off 08:48:47 INFO - Online: Yes 08:48:47 INFO - Rotation: Supported 08:48:47 INFO - Return code: 0 08:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:47 INFO - Python 2.7.3 08:48:47 INFO - Return code: 0 08:48:47 INFO - grabbing minidump binary from tooltool 08:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:47 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 0x1094f4d30>, '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 0x10931adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094ecb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:47 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 08:48:47 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 08:48:47 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 08:48:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:47 INFO - Return code: 0 08:48:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:48:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:48:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 08:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --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 08:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gVUUMGhnJO/Render', 08:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:47 INFO - 'HOME': '/Users/cltbld', 08:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:47 INFO - 'LOGNAME': 'cltbld', 08:48:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:47 INFO - 'MOZ_NO_REMOTE': '1', 08:48:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:47 INFO - 'NO_EM_RESTART': '1', 08:48:47 INFO - 'PAGER': '/bin/cat', 08:48:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:47 INFO - 'PWD': '/builds/slave/test', 08:48:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:47 INFO - 'SHELL': '/bin/bash', 08:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jTfYWnEpcw/Listeners', 08:48:47 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 08:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:47 INFO - 'USER': 'cltbld', 08:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:47 INFO - 'XPC_FLAGS': '0x0', 08:48:47 INFO - 'XPC_SERVICE_NAME': '0', 08:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 08:48:47 INFO - mozversion application_buildid: 20161006063200 08:48:47 INFO - mozversion application_changeset: fdda673f01a75e908a3fd50d2975931a2c753381 08:48:47 INFO - mozversion application_display_name: Nightly 08:48:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:47 INFO - mozversion application_name: Firefox 08:48:47 INFO - mozversion application_remotingname: firefox 08:48:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:48:47 INFO - mozversion application_vendor: Mozilla 08:48:47 INFO - mozversion application_version: 52.0a1 08:48:47 INFO - mozversion platform_buildid: 20161006063200 08:48:47 INFO - mozversion platform_changeset: fdda673f01a75e908a3fd50d2975931a2c753381 08:48:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:48:47 INFO - mozversion platform_version: 52.0a1 08:48:47 INFO - using testdate: 1475768927 08:48:47 INFO - actual date: 1475768927 08:48:47 INFO - starting webserver on 'localhost:49266' 08:48:47 INFO - SUITE-START | Running 2 tests 08:48:47 INFO - TEST-START | dromaeo_css 08:48:47 INFO - operating with platform_type : mac_ 08:48:47 INFO - Initialising browser for dromaeo_css test... 08:48:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpzRcbkX/profile http://localhost:49266/getInfo.html) 08:48:50 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:48:50 INFO - PROCESS | 1652 | colorDepth:24 08:48:50 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:48:50 INFO - PROCESS | 1652 | __metrics 08:48:50 INFO - PROCESS | 1652 | 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" 08:48:50 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:50 INFO - TEST-INFO | 1652: exit 0 08:48:50 INFO - Browser initialized. 08:48:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:50 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpzRcbkX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:03 INFO - PROCESS | 1655 | RSS: Main: 235831296 08:49:03 INFO - PROCESS | 1655 | 08:49:54 INFO - PROCESS | 1655 | 1475768994318 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] 08:52:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 08:52:09 INFO - PROCESS | 1655 | RSS: Main: 366129152 08:52:09 INFO - PROCESS | 1655 | 08:55:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 08:55:12 INFO - PROCESS | 1655 | RSS: Main: 372449280 08:55:12 INFO - PROCESS | 1655 | 08:58:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 08:58:15 INFO - PROCESS | 1655 | RSS: Main: 340754432 08:58:15 INFO - PROCESS | 1655 | 09:01:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 09:01:18 INFO - PROCESS | 1655 | RSS: Main: 366161920 09:01:18 INFO - PROCESS | 1655 | 09:04:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 09:04:22 INFO - PROCESS | 1655 | RSS: Main: 331505664 09:04:22 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 09:07:25 INFO - PROCESS | 1655 | RSS: Main: 382021632 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | __start_tp_report 09:07:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 09:07:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 09:07:25 INFO - PROCESS | 1655 | |i|pagename|runs| 09:07:25 INFO - PROCESS | 1655 | |0;dojo.html;3011.1869795155308;3312.2547426828964;3325.833708314584;3363.663633636635;3375.6793104655067;5580.832575022746;5665.461781130791;5678.205051292823;5750.56870734695;5765.913511297329;5668.178114173443;5682.460166284196;5756.453136951994;5763.308402991647;5784.508316793067;5080.060188865072;5105.336306280178;5126.231065340192;5128.846134615949;5201.011807756533;5262.236975638531;5265.86835329116;5275.182346736262;5280.498352656491;5347.304850369446;5264.131418315973;5265.6840589564745;5276.604254680914;5290.7354632268425;5352.330958630171;5131.923021154686;5137.820176293849;5190.948090519122;5193.221016847503;5200.219967004941;5138.409082955471;5147.382314122292;5171;5242.082635538765;5246.580273578104;5702.401247868956;5732.570057245724;5741.971290143564;5766;5769.394213607553;6127.448529632355;6137.7215594588615;6162.445379915829;6253.530985176085;6254.093156492283;6204.410580994799;6222.222222222223;6260.968695156541;6278.30938596754;6288.025356069817;5724.828255152311;5754.251947246831;5762.827115186551;5767.019606666877;5811.128330750421;6139.6009259398;6232.719527621268;6233.252009758858;6241.937580624136;6279.434850863353;6077.164518800292;6096.6350901395135;6097.9906604667885;6098.898644523722;6109.908351374733;6162.876742465126;6188.2883468400805;6216.937830621727;6224.128621992924;6242.968785156045;6175.44421002112;6242.75028998844;6246.406591373812;6257.2491301044165;6262.561620686508;6226.875462490725;6234.657093859791;6250.656213908279;6256.624602523863;6266.49868010558;4850.975745121252;4896.020795840846;4906.141425250638;4939.753012349368;4979.676321039121;4327.653787696977;4362.323839804835;4421.668374871898;4431.8670439886855;4474.7762611869275;5043.5460808527405;5709.400512946164;5744.396838331999;5783.450572195635;5794.971025144931;6251.343608921089;6260.655663938527;6261.405166509175;6265.216847894013;6281.748730050746;5645.858853528694;5700.857478562986;5705.62913410627;5729.1119876419225;5735.741891614887;5394.73026348681;5416.8104116355735;5418.45815418455;5420.349558053059;5424.755885985141;6181.258249010148;6185.597936134047;6224.221972253468;6237.688115594111;6260.060990851318;6139.548827100317;6147.108669243024;6164.260288765197;6175.5677102602385;6189.783357582463;6244.843878902882;6259.405356491126;6264.373562643699;6275.811725648238;6285.182926219562;6061.39386061408;6074.301455332693;6124.081387791689;6127.417895299939;6137.65279220269;6154.723037463415;6196.442320191204;6232.314445410911;6249.1563638908165;6275.435210831047;6112.786052488142;6114.602550834182;6123.14276001369;6144.969275153596;6149;5077.593792496666;6100.352904715791;6105.358937311696;6115.082737589397;6115.480184184216;5594.4125866785025;5849.912251316148;5850.94149058521;5857.824265272048;5919;6109.404666050238;6109.556495504338;6124.289394097845;6127.29536103336;6131.804871721949;5935.525157987437;5976.103584462366;6007.369226231182;6028.819135425944;6048.758049677964 09:07:25 INFO - PROCESS | 1655 | |1;ext.html;466.92996050592404;498.46913037614945;518.7172990720056;524.8268071536392;528.0995901987112;27061.729382706166;31069.37861242774;39022.80488597553;40553.79723101381;40752.59247407525;39416.40875386864;41655.583444165546;41702.37446438306;41714.165716685646;41736.37395439071;9567;9746.220302375792;9757.121859032686;9759.219262459023;9764.90235097647;9487.52562371882;9612.663556775515;9619.374740641872;9625.855612165824;9644.421334719938;9606.183474404685;9643.228541716646;9656.951715241414;9658.855117173249;9685.467299298536;9537.141657250846;9578.233741300679;9607.27945404094;9623.951880240624;9628.47043412612;9565.856512152322;9628.66299679508;9651.951740241253;9661.178799802025;9676.12914837668;39656.60343396558;39919.20161596752;39972.80013599942;40063.198736025406;40221.39667904984;3226.080567038383;3305.1571849178545;3316.9004929852144;3322.2691007978206;3407.9829600852086;30205.546916796266;31217.531737023965;31261.561228264873;31309.217269568217;31704.841475792473;3120.9687903120907;3154.8895788647515;3262.869485220588;3324.2520432902647;3375.088726043979;475423;477494;479092;480407;493356;55090.89818203614;55796.16305755417;55800.441995579524;55914.44085559174;56065.7196714022;57493.83783891926;57597;57627;57647.847043059744;57791.37668986471;15648.530544083696;15838.683226335408;15847.049177049414;15902.522924312289;15917.681646367007;12307;12311.19977201479;12371.69070773238;12378.319192444502;12393.938030309791;14194.503192388216;14553.708925821424;14829.703405932038;14879.776803347959;14913.850861491463;5938.984808523549;6046.576739628272;6110.938890611126;6117.877642447126;6130;845.8139209373928;886.3396769406833;935.8970513243673;972.7762614598682;972.9854052189223;28941;29078.563821542695;29503.85248073746;29876.253093672833;29882.954096606514;982.5922242269521;1054.2462139570243;1063.7819247054335;1121.2039451989017;1127.3179726265655;15036.323365448581;15135.394584216729;15175.544733658007;15383.923125381116;15575.844241557666;598116;598744;599190;601626;603257;55578.16632750512;55793.163102553495;55886.441135588124;56054.719726401105;56062.71968640131;1303.1008604063165;1364.454218312663;1366.7403193393025;1370.8766211040854;1375.1061809823696;28180.43639127165;28773.518885090445;29136.8345266187;29730.55404168896;29814;39921;47473;47917.28124078211;47939.28091078567;47946.5205347942;563432;567675;567950;568102;568146;37920.620793791706;38340.61659383371;38755.41866872056;38791.284610077026;38799.80600096982;44676.55323446854;45172;46096.308555372365;46293;46417.071658567314;37892.43161352527;38155.42766858444;38397.51602087186;38990.6100938987;39215.607843922335;36515.817420912725;36699.63300366962;37768.62231377651;37829;38030.049248769;36471.81764091163;37096.814515927246;37098;37110.54673439096;37384;32147.517787232744;33371.33257334888;33460.33079338351;33535.66464335325;33695.494567582;21984.670229946885;24347.634785477876;24975;25445.23664290074;25559.744402555738 09:07:25 INFO - PROCESS | 1655 | |2;jquery.html;355.6798881007095;356.62198070045747;369.6045231602185;382.74356181358496;402.51697962445076;15240.314185861635;15657.765133523006;16615.833841661595;21049.36851894442;21231.6815247771;17009;19395.806041939577;20216;20697.482562935933;20947.162113515442;5456.208849716789;5678.517326027282;5963.55273354498;5964.1650168976375;5973.729982606604;4807.759612019402;5582.888342233153;5925.229720136398;6174.259088909337;6176.135341052256;5838.503727183194;6070.696465176746;6118.847028824271;6119.785807496739;6127.938720612781;6054.606450580698;6113.419225173601;6119.816405507842;6121.234845644294;6121.571489995725;5122.667026643257;5254.8160814371695;5316.707581083039;5320.441353657849;5333.546648534879;25795.355116122246;26134.477310453876;26233.606495902575;26448;26650.866745666342;2074.263636409083;2273.6703178039256;2299.9310020699404;2347.354477518679;2418.987905060481;14892.62768430787;15409.537713868602;15606.921965390215;15819.52541423759;15987.360505579763;1869.9719504207449;1907.075068591732;1923.6152769446167;1952.5509132899372;1956.7358406615067;124912;125808;126904;130078.34960825136;131060.10229539694;10427.530761115768;10565.524551395205;11127;11133.332000080021;11280.32318060919;13952.372143253375;13956.2324072177;13956.441742330397;13960.650983725489;13967.092139010932;8326.750197494084;8600.827983440297;8619;8751.299896008304;8753;8627.309815214769;8649.783755406039;8654.48073115615;8857.822843543094;8880.51157186361;5933.762649494059;6612.603243805387;6718.294579069225;6718.7312507499155;6768.255491895888;1591.7214487464648;1615.4830454254525;1683.8568721658796;1748.606563523197;1809;916.5921165081608;944.5891037398753;1016.7407311135613;1022.3916769522123;1028.3624153025173;20849.478763030744;21500.452425349955;22608.434789130402;22644.433889152904;22690.886545567166;951.2960409297209;960.1262850805733;964.8745663063756;968.7696625285847;980.9607615695293;10549.578016879239;10908.890911090946;11604;12047.638570842888;12172.2696638202;596752;601400;611930;614311;614689;93510;114243;117447;137412;144851;965.5027660754857;968.2447690801046;980.8136454073704;1014.9949250253701;1016;15556.68886622284;19268.903655481634;19800.603987919872;19801.30695425653;19884.304049358205;38015;49491.25763113484;52831.71682831686;57589.71205143948;59227.223183304566;61497.692511537156;71825.92261116192;76423.8536421943;79893.4021319582;81091;6998.580085194904;7256.346928776436;7292.781216563511;7491.550506969599;7953.9602301990435;8930.419522731001;12849;12849.421776019915;13006.024548158737;13237.602871913858;10825.837612435977;11227.989480946753;11424.714382140513;11431.59989400367;11479.483423245807;9337.53312334367;10630.362178269328;10936.179786516203;11132.38771867555;11338.376389298668;11116.499757511094;11325.433728313716;11351.240557713567;11381.601643942422;11483.770324593293;7185.964070179824;7419.777406677808;7443.069616297963;7549.7357592483995;7651.579163146081;9367.484788336707;10388.065074143364;10414.843777343194;10431.634892778717;11118.277311974696 09:07:25 INFO - PROCESS | 1655 | |3;mootools.html;1470.6470447092695;1518.2181176694;1628.9737465396797;1687.5021868548777;1850.213659194842;8313.792155196115;8858.379913406065;8876.556172191396;8889.888763904512;8903.643854245838;7778.222177782219;7990;7997.360211183106;8371.91628083719;8638.913610863889;2303.0557471436714;2334.323046316566;2347.3310106619615;2347.6054424487015;2352;2122.8620139690947;2159.902804373807;2345.2377977157407;2357.257463898875;2359.6224604063354;2321.5008773113777;2335.322756400642;2342.1568235435316;2347.2019513365453;2352.752960939102;2324.23300310897;2325.9651105233434;2326.3951372643064;2330.2892617751577;2333.3583264602203;2303.332033710222;2332.346942856003;2334.334714606329;2337.625979843234;2341.730700969393;8610.182032706945;8816.779580510474;8821.338399620054;8822.823543529094;8825.07336729647;5121.359830021247;5279.1817268323475;5284.6564973277;5286.841394758163;5293.894122117575;3451.81015044175;3548.1307079765365;3685.852565897361;3687.4284485904727;3694.4273637585948;1088.646189988257;1089.9455027248684;1092.0771947704177;1111.1610733895857;1114.1977776001265;11420.972112509913;11538.250013749079;11558.479868405942;11567.76864462706;11598.594049208237;4467.374567560479;4532.524084971096;4719.268513380432;4730.455997560256;4730.550597693214;9920.503974801231;9939.707837981161;9942.502874856229;9951.601935922627;9977.700668979942;5285.101532739443;5294.973525132426;5296.09966305729;5297.920531192035;5299.12564426873;4304.461942257218;4338.305871060616;4348.086901750605;4844.297576851337;4859.659823812299;3796.9430458543143;3839.308924393636;3905.1994341159993;3933.8033098344968;3968.226195891831;1256.849178098634;1257.9748405031849;1261.375619068567;1275.6810797300675;1275.7002104505434;848.4612271207704;852.3564708644933;890.9109089091169;908.68650315641;932.1098351074843;3865.729398942103;5225.581953443715;5513.724313784375;5928.347881733092;6001.789937352171;891.3136884598823;935.1910597333258;958.152035448619;976.8241716490958;983.1348413396308;3592.2995015972156;3902.3951287550476;3965.0682089708894;3972.801359931992;3980.2636512245326;9629.32594718363;10281.845772313422;10419.270651054354;10576.52405641748;10585;10528.578856845641;10534.73663158412;10549.894501055045;10556.524956376828;10565.471726413649;7645.235476452311;7979.281864632095;8056.919430805734;8157.510549366938;8164.428490005643;5621.578381621313;5842.853928651818;5895.644001879506;5896.410358964241;5917.289925209003;9727.027297270217;9993.10062094415;10007.349522281029;10010.499475026365;10046.648367307109;9660.806783864424;9929.056739609725;10032.64885728996;10120.240981926532;10161.748240562949;6988.37104660583;7221.31397517235;7229;7420.295071968154;7585.50694204897;8055.476394034369;8367.748967530984;8367.916320836957;8459.98480182382;8466.915330846612;7341;7365.631718413951;7543.283388078124;7655.119661238806;7678.232176782277;7196.136463624399;7325.597092159769;7328.853422931405;7496.475246732676;7510.39916806665;6200.100985357189;6806.523543351917;6855.451563874978;7022.894656580053;7026;4893.363862697826;4948.208286674115;4967.180415231446;5004.1492946198505;5047.343845300087;3663.5420572428447;4080.8979775504663;4861.546421499861;4965.900681986413;5159.871003224949 09:07:25 INFO - PROCESS | 1655 | |4;prototype.html;258.2304731898941;301.81890865480716;309.44300259532844;314.73876682353637;318.92505261263585;4820.879478013043;5103.489651034894;5210.791568337267;5304.575633949285;5333.519983201511;4886.218205087187;5072.923906141411;5143.588512918966;5159.432462429129;5178.8606506568585;3513.7540372173958;3811.6378944000276;3969.8412063517426;3984.900377490557;4011.638952494275;3034.679914237303;3725.627437256266;3963.8414463421427;4021.9597804022023;4028.274910516106;3884.009577557719;3892.06590418299;3928.5874983126787;3931.9213615727667;3942.8619998300064;3315.6352801192093;3354.4465163248033;3898.9805050974705;3937.8818635440985;3951.044233104603;2842.332051967786;3143.695366422932;3175.903903423752;3266.3304022675534;3409.7613167078316;5089.338386009832;5091.363579552556;5099.286099946011;5103.668261563023;5126.948730512721;3836.7889766062854;4406.788133263346;4547.45430548333;4591.862244132682;4597.563231493003;5268;5419.458054194549;5555.388907220203;5562.7774889004395;5580.832575022715;3442.416488415332;3726.9254614907823;3763.924721505582;3766.6986641068925;3769.886903392875;4300.720453170566;5788.739506722165;5803.314895041679;5809.854753631151;5859.824205273849;3147.984260078685;3397.3545026444895;3665.6700896919406;3837.597052309523;3924.548676902136;3872.9225415491533;3874.535055793323;3895.7857317847224;3905.33609286422;3920.843166273317;4535.4103966484145;4547.9279720035665;4550.431196100488;4554.521775213621;4590.6557008223845;4491.955080449219;4871.124617022472;5603.187537806995;5615.382307946123;5665.883763929822;1240.2000709542294;1313.8620444853343;1322.3983087695076;1336.692560711042;1339.1964821107258;704.0178950364214;805.8791181322848;815.502543448496;819.2299238715589;831.8918540589684;4035.2131334389514;4260.233158031522;4288.935665965013;4336;4350.912981740347;4060;4209.3896385024;4541.863744087683;4654.720716757005;4691.1555919934735;3718.2710039831068;4182.832686692559;4292.647815937969;4309;4309.836344187114;2033.8102210207194;2222.8888555572157;2364.8294094423372;2506.8495890246277;2527.721950585434;4121.464209652786;4525.389072475239;4772.780656994514;4882.607522314041;4940.975295123573;4516.119356725473;4817.325574419584;4834.6374021948495;4835.323054772335;4850.83022094225;4366.5679335474515;4748.477667456577;5326.866828329323;5423.29497165366;5711.057675483665;4753.668972687653;5710.543156547549;5731.56106336195;5816.5055970243;5833.941660583339;5251.448597897166;5742.339630942328;5761.942380576308;5762.954151276236;5768.336641286138;5143.665661731976;5359.330083739533;5863.384344643751;5865.706714664165;5917.704114794329;3755.2114056047444;3882.6893848491486;3902.2195560888504;3930.76415415076;3960.4455376247925;5257.78968841242;5325.009364464977;5575.303087114111;5749.741261643152;5796.971015144897;5584;5592.86017849557;5608.766071464272;5612.4668156526695;5660.886782264414;4903.828366007173;5228.947710522846;5567;5600.35595906476;5609.80365687199;4589.609883159968;5474.644148130359;5492.642978206404;5526.148740172087;5538.584606154474;5054.924176137288;5187.98834227322;5667.971660141673;5688.070643618623;5693.345265294379;4581.198290299118;4776.617870570415;5217.791288348423;5408.404520666491;5456.7544460498575 09:07:25 INFO - PROCESS | 1655 | |5;yui.html;604.6402390577607;766.7738017284897;781.7570063598877;819.7167621187896;821.7452589697198;15161.545153645395;16565.66868662626;17174;17439.825601743978;17506.737398939025;15804.84195158048;15904.204789760524;16012.759808602852;16066.839331606681;16074.678506429864;843.493903657805;864.2135656552539;873.995630021849;874.4359887872318;875.2254254984321;652.4291245160484;678.3453966921919;865.7835541114721;870.4820631724114;871.4553404122423;740.3484933258752;879.1647934462254;908.0148039377251;914.2457472585144;918.6279556779482;893.9597718102701;894.6823877523483;896.9416987895798;897.8114595934861;901.2069378946551;534.4815528936925;663.383053760003;664.1764212376667;665.490899461912;666.7333066773281;12517.687057823536;12761.489540418464;12771.361431928459;12771.808422873664;14812.111273323528;13701.314934253347;14260.358283877147;14375.209363485004;14424.639384015378;14852.480163194236;11468.541258349656;11817.527298908033;11900.880991190064;11982.820257696141;12374.938125309316;3736.4768932349493;3805.8667946622013;3810.542734871833;3875.399313106445;3962.5244970603712;95862;97516;101261.4936925318;124652;126058;10920.50857711405;10930.945345273223;11014.229003969805;11104.944475277573;11408.372539510407;21609.027593758317;21614.56770864574;21627.459313516974;21627.783722162578;21657.67513487299;7768.339691126204;7806;7839.804004899923;7914.366850651934;7922.128565857751;4237.8304867805555;4330.458692663417;4334.739915605074;4336.046069864625;4446.466424029137;3564.411872041136;3728.6457786510236;3730.0861288984374;3734.79458629778;3737.5141231639714;688.9414399776075;723.0636325957897;723.5513981331608;725.3508110241304;725.3870479444861;536.8174820561028;540.7377421950351;565.1381642994385;594.3699678340972;671.7480944645757;8521.57392130391;9371.578278977462;9491.810163796823;9519.428834269966;9668.564914578861;514.6603241860354;543.098456562105;585.9970700146472;642.6915080761261;686.807693845724;4175.937360939588;4622.006268652256;4652.116097941381;4692.976535117303;4710.317004034464;145799;156852.21573892285;157492.3134608174;158370;159521;86419.56790216008;88180;88557.55721221352;91663;99782;88677.24550299591;95524;113135.86864131418;117433;120964.39517802355;8718.258947989492;8934.910650893407;8953.059928707653;8957.910420895707;9011.316259678171;56623.392204598786;59422;59571;63283.6835815818;64326.67836660787;71641.64179179071;95149;100134.4993275029;100540.44865737743;103596.44605330775;11445.370504622326;11656.88343116558;11784.941075294568;11934.641960741192;12375.504979800708;12799.872001279868;13105.672358191121;13159.725673392611;13575;13651.590452286448;11625.825612615648;11838.112141589243;12018.33899135521;12043.939780301042;12466.127371083938;11941.204872051352;12126;12174;12180.208286461351;12576.371181440709;11838.763224735629;12128.090393220367;12289.938550307192;12304.200226985216;12537.811932820832;9899.604015839574;10159.238057145596;10330.121939635215;10332.741681457723;10450.42522661261;9794.26543009263;10133.847992280269;10168.440735759605;10201.234907381828;10234.6417875374 09:07:25 INFO - PROCESS | 1655 | __end_tp_report 09:07:25 INFO - PROCESS | 1655 | __start_cc_report 09:07:25 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1333 09:07:25 INFO - PROCESS | 1655 | __end_cc_report 09:07:25 INFO - PROCESS | 1655 | __startTimestamp1475770045936__endTimestamp 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | ------- Summary: start ------- 09:07:25 INFO - PROCESS | 1655 | Number of tests: 6 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5726.46 Median:5976.10 stddev:644.95 (10.8%) stddev-sans-first:610.74 09:07:25 INFO - PROCESS | 1655 | Values: 3011.2 3312.3 3325.8 3363.7 3375.7 5580.8 5665.5 5678.2 5750.6 5765.9 5668.2 5682.5 5756.5 5763.3 5784.5 5080.1 5105.3 5126.2 5128.8 5201.0 5262.2 5265.9 5275.2 5280.5 5347.3 5264.1 5265.7 5276.6 5290.7 5352.3 5131.9 5137.8 5190.9 5193.2 5200.2 5138.4 5147.4 5171.0 5242.1 5246.6 5702.4 5732.6 5742.0 5766.0 5769.4 6127.4 6137.7 6162.4 6253.5 6254.1 6204.4 6222.2 6261.0 6278.3 6288.0 5724.8 5754.3 5762.8 5767.0 5811.1 6139.6 6232.7 6233.3 6241.9 6279.4 6077.2 6096.6 6098.0 6098.9 6109.9 6162.9 6188.3 6216.9 6224.1 6243.0 6175.4 6242.8 6246.4 6257.2 6262.6 6226.9 6234.7 6250.7 6256.6 6266.5 4851.0 4896.0 4906.1 4939.8 4979.7 4327.7 4362.3 4421.7 4431.9 4474.8 5043.5 5709.4 5744.4 5783.5 5795.0 6251.3 6260.7 6261.4 6265.2 6281.7 5645.9 5700.9 5705.6 5729.1 5735.7 5394.7 5416.8 5418.5 5420.3 5424.8 6181.3 6185.6 6224.2 6237.7 6260.1 6139.5 6147.1 6164.3 6175.6 6189.8 6244.8 6259.4 6264.4 6275.8 6285.2 6061.4 6074.3 6124.1 6127.4 6137.7 6154.7 6196.4 6232.3 6249.2 6275.4 6112.8 6114.6 6123.1 6145.0 6149.0 5077.6 6100.4 6105.4 6115.1 6115.5 5594.4 5849.9 5850.9 5857.8 5919.0 6109.4 6109.6 6124.3 6127.3 6131.8 5935.5 5976.1 6007.4 6028.8 6048.8 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:68005.63 Median:39946.90 stddev:147298.70 (368.7%) stddev-sans-first:147624.62 09:07:25 INFO - PROCESS | 1655 | Values: 466.9 498.5 518.7 524.8 528.1 27061.7 31069.4 39022.8 40553.8 40752.6 39416.4 41655.6 41702.4 41714.2 41736.4 9567.0 9746.2 9757.1 9759.2 9764.9 9487.5 9612.7 9619.4 9625.9 9644.4 9606.2 9643.2 9657.0 9658.9 9685.5 9537.1 9578.2 9607.3 9624.0 9628.5 9565.9 9628.7 9652.0 9661.2 9676.1 39656.6 39919.2 39972.8 40063.2 40221.4 3226.1 3305.2 3316.9 3322.3 3408.0 30205.5 31217.5 31261.6 31309.2 31704.8 3121.0 3154.9 3262.9 3324.3 3375.1 475423.0 477494.0 479092.0 480407.0 493356.0 55090.9 55796.2 55800.4 55914.4 56065.7 57493.8 57597.0 57627.0 57647.8 57791.4 15648.5 15838.7 15847.0 15902.5 15917.7 12307.0 12311.2 12371.7 12378.3 12393.9 14194.5 14553.7 14829.7 14879.8 14913.9 5939.0 6046.6 6110.9 6117.9 6130.0 845.8 886.3 935.9 972.8 973.0 28941.0 29078.6 29503.9 29876.3 29883.0 982.6 1054.2 1063.8 1121.2 1127.3 15036.3 15135.4 15175.5 15383.9 15575.8 598116.0 598744.0 599190.0 601626.0 603257.0 55578.2 55793.2 55886.4 56054.7 56062.7 1303.1 1364.5 1366.7 1370.9 1375.1 28180.4 28773.5 29136.8 29730.6 29814.0 39921.0 47473.0 47917.3 47939.3 47946.5 563432.0 567675.0 567950.0 568102.0 568146.0 37920.6 38340.6 38755.4 38791.3 38799.8 44676.6 45172.0 46096.3 46293.0 46417.1 37892.4 38155.4 38397.5 38990.6 39215.6 36515.8 36699.6 37768.6 37829.0 38030.0 36471.8 37096.8 37098.0 37110.5 37384.0 32147.5 33371.3 33460.3 33535.7 33695.5 21984.7 24347.6 24975.0 25445.2 25559.7 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35333.76 Median:14107.17 stddev:101424.56 (719.0%) stddev-sans-first:101675.08 09:07:25 INFO - PROCESS | 1655 | Values: 355.7 356.6 369.6 382.7 402.5 15240.3 15657.8 16615.8 21049.4 21231.7 17009.0 19395.8 20216.0 20697.5 20947.2 5456.2 5678.5 5963.6 5964.2 5973.7 4807.8 5582.9 5925.2 6174.3 6176.1 5838.5 6070.7 6118.8 6119.8 6127.9 6054.6 6113.4 6119.8 6121.2 6121.6 5122.7 5254.8 5316.7 5320.4 5333.5 25795.4 26134.5 26233.6 26448.0 26650.9 2074.3 2273.7 2299.9 2347.4 2419.0 14892.6 15409.5 15606.9 15819.5 15987.4 1870.0 1907.1 1923.6 1952.6 1956.7 124912.0 125808.0 126904.0 130078.3 131060.1 10427.5 10565.5 11127.0 11133.3 11280.3 13952.4 13956.2 13956.4 13960.7 13967.1 8326.8 8600.8 8619.0 8751.3 8753.0 8627.3 8649.8 8654.5 8857.8 8880.5 5933.8 6612.6 6718.3 6718.7 6768.3 1591.7 1615.5 1683.9 1748.6 1809.0 916.6 944.6 1016.7 1022.4 1028.4 20849.5 21500.5 22608.4 22644.4 22690.9 951.3 960.1 964.9 968.8 981.0 10549.6 10908.9 11604.0 12047.6 12172.3 596752.0 601400.0 611930.0 614311.0 614689.0 93510.0 114243.0 117447.0 137412.0 144851.0 965.5 968.2 980.8 1015.0 1016.0 15556.7 19268.9 19800.6 19801.3 19884.3 38015.0 49491.3 52831.7 57589.7 59227.2 61497.7 71825.9 76423.9 79893.4 81091.0 6998.6 7256.3 7292.8 7491.6 7954.0 8930.4 12849.0 12849.4 13006.0 13237.6 10825.8 11228.0 11424.7 11431.6 11479.5 9337.5 10630.4 10936.2 11132.4 11338.4 11116.5 11325.4 11351.2 11381.6 11483.8 7186.0 7419.8 7443.1 7549.7 7651.6 9367.5 10388.1 10414.8 10431.6 11118.3 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5624.32 Median:4957.05 stddev:3160.83 (63.8%) stddev-sans-first:3154.28 09:07:25 INFO - PROCESS | 1655 | Values: 1470.6 1518.2 1629.0 1687.5 1850.2 8313.8 8858.4 8876.6 8889.9 8903.6 7778.2 7990.0 7997.4 8371.9 8638.9 2303.1 2334.3 2347.3 2347.6 2352.0 2122.9 2159.9 2345.2 2357.3 2359.6 2321.5 2335.3 2342.2 2347.2 2352.8 2324.2 2326.0 2326.4 2330.3 2333.4 2303.3 2332.3 2334.3 2337.6 2341.7 8610.2 8816.8 8821.3 8822.8 8825.1 5121.4 5279.2 5284.7 5286.8 5293.9 3451.8 3548.1 3685.9 3687.4 3694.4 1088.6 1089.9 1092.1 1111.2 1114.2 11421.0 11538.3 11558.5 11567.8 11598.6 4467.4 4532.5 4719.3 4730.5 4730.6 9920.5 9939.7 9942.5 9951.6 9977.7 5285.1 5295.0 5296.1 5297.9 5299.1 4304.5 4338.3 4348.1 4844.3 4859.7 3796.9 3839.3 3905.2 3933.8 3968.2 1256.8 1258.0 1261.4 1275.7 1275.7 848.5 852.4 890.9 908.7 932.1 3865.7 5225.6 5513.7 5928.3 6001.8 891.3 935.2 958.2 976.8 983.1 3592.3 3902.4 3965.1 3972.8 3980.3 9629.3 10281.8 10419.3 10576.5 10585.0 10528.6 10534.7 10549.9 10556.5 10565.5 7645.2 7979.3 8056.9 8157.5 8164.4 5621.6 5842.9 5895.6 5896.4 5917.3 9727.0 9993.1 10007.3 10010.5 10046.6 9660.8 9929.1 10032.6 10120.2 10161.7 6988.4 7221.3 7229.0 7420.3 7585.5 8055.5 8367.7 8367.9 8460.0 8466.9 7341.0 7365.6 7543.3 7655.1 7678.2 7196.1 7325.6 7328.9 7496.5 7510.4 6200.1 6806.5 6855.5 7022.9 7026.0 4893.4 4948.2 4967.2 5004.1 5047.3 3663.5 4080.9 4861.5 4965.9 5159.9 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4316.00 Median:4626.14 stddev:1363.30 (29.5%) stddev-sans-first:1332.67 09:07:25 INFO - PROCESS | 1655 | Values: 258.2 301.8 309.4 314.7 318.9 4820.9 5103.5 5210.8 5304.6 5333.5 4886.2 5072.9 5143.6 5159.4 5178.9 3513.8 3811.6 3969.8 3984.9 4011.6 3034.7 3725.6 3963.8 4022.0 4028.3 3884.0 3892.1 3928.6 3931.9 3942.9 3315.6 3354.4 3899.0 3937.9 3951.0 2842.3 3143.7 3175.9 3266.3 3409.8 5089.3 5091.4 5099.3 5103.7 5126.9 3836.8 4406.8 4547.5 4591.9 4597.6 5268.0 5419.5 5555.4 5562.8 5580.8 3442.4 3726.9 3763.9 3766.7 3769.9 4300.7 5788.7 5803.3 5809.9 5859.8 3148.0 3397.4 3665.7 3837.6 3924.5 3872.9 3874.5 3895.8 3905.3 3920.8 4535.4 4547.9 4550.4 4554.5 4590.7 4492.0 4871.1 5603.2 5615.4 5665.9 1240.2 1313.9 1322.4 1336.7 1339.2 704.0 805.9 815.5 819.2 831.9 4035.2 4260.2 4288.9 4336.0 4350.9 4060.0 4209.4 4541.9 4654.7 4691.2 3718.3 4182.8 4292.6 4309.0 4309.8 2033.8 2222.9 2364.8 2506.8 2527.7 4121.5 4525.4 4772.8 4882.6 4941.0 4516.1 4817.3 4834.6 4835.3 4850.8 4366.6 4748.5 5326.9 5423.3 5711.1 4753.7 5710.5 5731.6 5816.5 5833.9 5251.4 5742.3 5761.9 5763.0 5768.3 5143.7 5359.3 5863.4 5865.7 5917.7 3755.2 3882.7 3902.2 3930.8 3960.4 5257.8 5325.0 5575.3 5749.7 5797.0 5584.0 5592.9 5608.8 5612.5 5660.9 4903.8 5228.9 5567.0 5600.4 5609.8 4589.6 5474.6 5492.6 5526.1 5538.6 5054.9 5188.0 5668.0 5688.1 5693.3 4581.2 4776.6 5217.8 5408.4 5456.8 09:07:25 INFO - PROCESS | 1655 | 09:07:25 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23708.38 Median:3918.96 stddev:37972.98 (969.0%) stddev-sans-first:38039.88 09:07:25 INFO - PROCESS | 1655 | Values: 604.6 766.8 781.8 819.7 821.7 15161.5 16565.7 17174.0 17439.8 17506.7 15804.8 15904.2 16012.8 16066.8 16074.7 843.5 864.2 874.0 874.4 875.2 652.4 678.3 865.8 870.5 871.5 740.3 879.2 908.0 914.2 918.6 894.0 894.7 896.9 897.8 901.2 534.5 663.4 664.2 665.5 666.7 12517.7 12761.5 12771.4 12771.8 14812.1 13701.3 14260.4 14375.2 14424.6 14852.5 11468.5 11817.5 11900.9 11982.8 12374.9 3736.5 3805.9 3810.5 3875.4 3962.5 95862.0 97516.0 101261.5 124652.0 126058.0 10920.5 10930.9 11014.2 11104.9 11408.4 21609.0 21614.6 21627.5 21627.8 21657.7 7768.3 7806.0 7839.8 7914.4 7922.1 4237.8 4330.5 4334.7 4336.0 4446.5 3564.4 3728.6 3730.1 3734.8 3737.5 688.9 723.1 723.6 725.4 725.4 536.8 540.7 565.1 594.4 671.7 8521.6 9371.6 9491.8 9519.4 9668.6 514.7 543.1 586.0 642.7 686.8 4175.9 4622.0 4652.1 4693.0 4710.3 145799.0 156852.2 157492.3 158370.0 159521.0 86419.6 88180.0 88557.6 91663.0 99782.0 88677.2 95524.0 113135.9 117433.0 120964.4 8718.3 8934.9 8953.1 8957.9 9011.3 56623.4 59422.0 59571.0 63283.7 64326.7 71641.6 95149.0 100134.5 100540.4 103596.4 11445.4 11656.9 11784.9 11934.6 12375.5 12799.9 13105.7 13159.7 13575.0 13651.6 11625.8 11838.1 12018.3 12043.9 12466.1 11941.2 12126.0 12174.0 12180.2 12576.4 11838.8 12128.1 12289.9 12304.2 12537.8 9899.6 10159.2 10330.1 10332.7 10450.4 9794.3 10133.8 10168.4 10201.2 10234.6 09:07:25 INFO - PROCESS | 1655 | -------- Summary: end -------- 09:07:25 INFO - PROCESS | 1655 | 09:07:26 INFO - TEST-INFO | 1655: exit 0 09:07:26 INFO - TEST-OK | dromaeo_css | took 1119038ms 09:07:26 INFO - TEST-START | kraken 09:07:26 INFO - operating with platform_type : mac_ 09:07:26 INFO - Initialising browser for kraken test... 09:07:26 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmphuOT8C/profile http://localhost:49266/getInfo.html) 09:07:28 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:07:28 INFO - PROCESS | 1661 | colorDepth:24 09:07:28 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:07:28 INFO - PROCESS | 1661 | __metrics 09:07:28 INFO - PROCESS | 1661 | 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" 09:07:28 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:29 INFO - TEST-INFO | 1661: exit 0 09:07:29 INFO - Browser initialized. 09:07:29 INFO - Running cycle 1/1 for kraken test... 09:07:29 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmphuOT8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:41 INFO - PROCESS | 1662 | RSS: Main: 236298240 09:07:41 INFO - PROCESS | 1662 | 09:07:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:45 INFO - PROCESS | 1662 | RSS: Main: 295038976 09:07:45 INFO - PROCESS | 1662 | 09:07:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 09:07:48 INFO - PROCESS | 1662 | RSS: Main: 294211584 09:07:48 INFO - PROCESS | 1662 | 09:07:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 09:07:52 INFO - PROCESS | 1662 | RSS: Main: 385572864 09:07:52 INFO - PROCESS | 1662 | 09:07:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 09:07:55 INFO - PROCESS | 1662 | RSS: Main: 289939456 09:07:55 INFO - PROCESS | 1662 | 09:07:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:58 INFO - PROCESS | 1662 | RSS: Main: 292020224 09:07:58 INFO - PROCESS | 1662 | 09:08:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:01 INFO - PROCESS | 1662 | RSS: Main: 329334784 09:08:01 INFO - PROCESS | 1662 | 09:08:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:05 INFO - PROCESS | 1662 | RSS: Main: 330416128 09:08:05 INFO - PROCESS | 1662 | 09:08:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 09:08:08 INFO - PROCESS | 1662 | RSS: Main: 327905280 09:08:08 INFO - PROCESS | 1662 | 09:08:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:10 INFO - PROCESS | 1662 | RSS: Main: 303067136 09:08:10 INFO - PROCESS | 1662 | 09:08:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:13 INFO - PROCESS | 1662 | RSS: Main: 308371456 09:08:13 INFO - PROCESS | 1662 | 09:08:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:16 INFO - PROCESS | 1662 | RSS: Main: 313270272 09:08:16 INFO - PROCESS | 1662 | 09:08:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:19 INFO - PROCESS | 1662 | RSS: Main: 330698752 09:08:19 INFO - PROCESS | 1662 | 09:08:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:23 INFO - PROCESS | 1662 | RSS: Main: 323952640 09:08:23 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 09:08:25 INFO - PROCESS | 1662 | RSS: Main: 368111616 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | __start_tp_report 09:08:25 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:08:25 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:08:25 INFO - PROCESS | 1662 | |i|pagename|runs| 09:08:25 INFO - PROCESS | 1662 | |0;ai-astar;112;113;112;112;111;112;113;111;112;111 09:08:25 INFO - PROCESS | 1662 | |1;audio-beat-detection;158;143;139;148;113;113;111;115;143;110 09:08:25 INFO - PROCESS | 1662 | |2;audio-dft;182;185;184;185;184;182;184;181;181;184 09:08:25 INFO - PROCESS | 1662 | |3;audio-fft;80;59;60;88;63;72;82;82;83;58 09:08:25 INFO - PROCESS | 1662 | |4;audio-oscillator;85;70;94;71;82;100;130;78;68;90 09:08:25 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;85;89;85;88;84;88;85;88;84 09:08:25 INFO - PROCESS | 1662 | |6;imaging-darkroom;119;151;94;94;93;94;107;150;116;94 09:08:25 INFO - PROCESS | 1662 | |7;imaging-desaturate;101;122;140;131;116;84;84;83;84;83 09:08:25 INFO - PROCESS | 1662 | |8;json-parse-financial;56;54;54;52;52;53;53;54;55;53 09:08:25 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;72;64;85;111;107;84;71;71;70 09:08:25 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;86;90;86;87;83;87;88;87;86;91 09:08:25 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;150;160;155;157;152;148;152;154;185;147 09:08:25 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;176;174;171;171;171;173;171;170;171;171 09:08:25 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;68;69;68;67;68;68;67;67;66 09:08:25 INFO - PROCESS | 1662 | __end_tp_report 09:08:25 INFO - PROCESS | 1662 | __start_cc_report 09:08:25 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1967 09:08:25 INFO - PROCESS | 1662 | __end_cc_report 09:08:25 INFO - PROCESS | 1662 | __startTimestamp1475770105412__endTimestamp 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:08:25 INFO - PROCESS | 1662 | Number of tests: 14 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 09:08:25 INFO - PROCESS | 1662 | Values: 112.0 113.0 112.0 112.0 111.0 112.0 113.0 111.0 112.0 111.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:141.00 stddev:18.52 (13.1%) stddev-sans-first:16.47 09:08:25 INFO - PROCESS | 1662 | Values: 158.0 143.0 139.0 148.0 113.0 113.0 111.0 115.0 143.0 110.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.55 (0.8%) stddev-sans-first:1.58 09:08:25 INFO - PROCESS | 1662 | Values: 182.0 185.0 184.0 185.0 184.0 182.0 184.0 181.0 181.0 184.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:72.70 Median:81.00 stddev:11.67 (14.4%) stddev-sans-first:12.08 09:08:25 INFO - PROCESS | 1662 | Values: 80.0 59.0 60.0 88.0 63.0 72.0 82.0 82.0 83.0 58.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:80.00 stddev:18.53 (23.2%) stddev-sans-first:19.65 09:08:25 INFO - PROCESS | 1662 | Values: 85.0 70.0 94.0 71.0 82.0 100.0 130.0 78.0 68.0 90.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.89 (2.2%) stddev-sans-first:1.99 09:08:25 INFO - PROCESS | 1662 | Values: 87.0 85.0 89.0 85.0 88.0 84.0 88.0 85.0 88.0 84.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:93.50 stddev:22.87 (24.5%) stddev-sans-first:24.08 09:08:25 INFO - PROCESS | 1662 | Values: 119.0 151.0 94.0 94.0 93.0 94.0 107.0 150.0 116.0 94.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:83.00 stddev:22.53 (27.1%) stddev-sans-first:23.89 09:08:25 INFO - PROCESS | 1662 | Values: 101.0 122.0 140.0 131.0 116.0 84.0 84.0 83.0 84.0 83.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:1.26 (2.3%) stddev-sans-first:1.00 09:08:25 INFO - PROCESS | 1662 | Values: 56.0 54.0 54.0 52.0 52.0 53.0 53.0 54.0 55.0 53.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:71.00 stddev:16.79 (23.7%) stddev-sans-first:16.91 09:08:25 INFO - PROCESS | 1662 | Values: 65.0 72.0 64.0 85.0 111.0 107.0 84.0 71.0 71.0 70.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.23 (2.6%) stddev-sans-first:2.33 09:08:25 INFO - PROCESS | 1662 | Values: 86.0 90.0 86.0 87.0 83.0 87.0 88.0 87.0 86.0 91.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:154.50 stddev:10.93 (7.1%) stddev-sans-first:11.38 09:08:25 INFO - PROCESS | 1662 | Values: 150.0 160.0 155.0 157.0 152.0 148.0 152.0 154.0 185.0 147.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:171.00 stddev:1.85 (1.1%) stddev-sans-first:1.24 09:08:25 INFO - PROCESS | 1662 | Values: 176.0 174.0 171.0 171.0 171.0 173.0 171.0 170.0 171.0 171.0 09:08:25 INFO - PROCESS | 1662 | 09:08:25 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 09:08:25 INFO - PROCESS | 1662 | Values: 68.0 68.0 69.0 68.0 67.0 68.0 68.0 67.0 67.0 66.0 09:08:25 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:08:25 INFO - PROCESS | 1662 | 09:08:26 INFO - TEST-INFO | 1662: exit 0 09:08:26 INFO - TEST-OK | kraken | took 59787ms 09:08:26 INFO - SUITE-END | took 1178s 09:08:26 INFO - Completed test suite (00:19:39) 09:08:26 INFO - javascript benchmark 09:08:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.1869795155308, 3312.2547426828964, 3325.833708314584, 3363.663633636635, 3375.6793104655067, 5580.832575022746, 5665.461781130791, 5678.205051292823, 5750.56870734695, 5765.913511297329, 5668.178114173443, 5682.460166284196, 5756.453136951994, 5763.308402991647, 5784.508316793067, 5080.060188865072, 5105.336306280178, 5126.231065340192, 5128.846134615949, 5201.011807756533, 5262.236975638531, 5265.86835329116, 5275.182346736262, 5280.498352656491, 5347.304850369446, 5264.131418315973, 5265.6840589564745, 5276.604254680914, 5290.7354632268425, 5352.330958630171, 5131.923021154686, 5137.820176293849, 5190.948090519122, 5193.221016847503, 5200.219967004941, 5138.409082955471, 5147.382314122292, 5171.0, 5242.082635538765, 5246.580273578104, 5702.401247868956, 5732.570057245724, 5741.971290143564, 5766.0, 5769.394213607553, 6127.448529632355, 6137.7215594588615, 6162.445379915829, 6253.530985176085, 6254.093156492283, 6204.410580994799, 6222.222222222223, 6260.968695156541, 6278.30938596754, 6288.025356069817, 5724.828255152311, 5754.251947246831, 5762.827115186551, 5767.019606666877, 5811.128330750421, 6139.6009259398, 6232.719527621268, 6233.252009758858, 6241.937580624136, 6279.434850863353, 6077.164518800292, 6096.6350901395135, 6097.9906604667885, 6098.898644523722, 6109.908351374733, 6162.876742465126, 6188.2883468400805, 6216.937830621727, 6224.128621992924, 6242.968785156045, 6175.44421002112, 6242.75028998844, 6246.406591373812, 6257.2491301044165, 6262.561620686508, 6226.875462490725, 6234.657093859791, 6250.656213908279, 6256.624602523863, 6266.49868010558, 4850.975745121252, 4896.020795840846, 4906.141425250638, 4939.753012349368, 4979.676321039121, 4327.653787696977, 4362.323839804835, 4421.668374871898, 4431.8670439886855, 4474.7762611869275, 5043.5460808527405, 5709.400512946164, 5744.396838331999, 5783.450572195635, 5794.971025144931, 6251.343608921089, 6260.655663938527, 6261.405166509175, 6265.216847894013, 6281.748730050746, 5645.858853528694, 5700.857478562986, 5705.62913410627, 5729.1119876419225, 5735.741891614887, 5394.73026348681, 5416.8104116355735, 5418.45815418455, 5420.349558053059, 5424.755885985141, 6181.258249010148, 6185.597936134047, 6224.221972253468, 6237.688115594111, 6260.060990851318, 6139.548827100317, 6147.108669243024, 6164.260288765197, 6175.5677102602385, 6189.783357582463, 6244.843878902882, 6259.405356491126, 6264.373562643699, 6275.811725648238, 6285.182926219562, 6061.39386061408, 6074.301455332693, 6124.081387791689, 6127.417895299939, 6137.65279220269, 6154.723037463415, 6196.442320191204, 6232.314445410911, 6249.1563638908165, 6275.435210831047, 6112.786052488142, 6114.602550834182, 6123.14276001369, 6144.969275153596, 6149.0, 5077.593792496666, 6100.352904715791, 6105.358937311696, 6115.082737589397, 6115.480184184216, 5594.4125866785025, 5849.912251316148, 5850.94149058521, 5857.824265272048, 5919.0, 6109.404666050238, 6109.556495504338, 6124.289394097845, 6127.29536103336, 6131.804871721949, 5935.525157987437, 5976.103584462366, 6007.369226231182, 6028.819135425944, 6048.758049677964], "value": 5683.809003586996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.92996050592404, 498.46913037614945, 518.7172990720056, 524.8268071536392, 528.0995901987112, 27061.729382706166, 31069.37861242774, 39022.80488597553, 40553.79723101381, 40752.59247407525, 39416.40875386864, 41655.583444165546, 41702.37446438306, 41714.165716685646, 41736.37395439071, 9567.0, 9746.220302375792, 9757.121859032686, 9759.219262459023, 9764.90235097647, 9487.52562371882, 9612.663556775515, 9619.374740641872, 9625.855612165824, 9644.421334719938, 9606.183474404685, 9643.228541716646, 9656.951715241414, 9658.855117173249, 9685.467299298536, 9537.141657250846, 9578.233741300679, 9607.27945404094, 9623.951880240624, 9628.47043412612, 9565.856512152322, 9628.66299679508, 9651.951740241253, 9661.178799802025, 9676.12914837668, 39656.60343396558, 39919.20161596752, 39972.80013599942, 40063.198736025406, 40221.39667904984, 3226.080567038383, 3305.1571849178545, 3316.9004929852144, 3322.2691007978206, 3407.9829600852086, 30205.546916796266, 31217.531737023965, 31261.561228264873, 31309.217269568217, 31704.841475792473, 3120.9687903120907, 3154.8895788647515, 3262.869485220588, 3324.2520432902647, 3375.088726043979, 475423.0, 477494.0, 479092.0, 480407.0, 493356.0, 55090.89818203614, 55796.16305755417, 55800.441995579524, 55914.44085559174, 56065.7196714022, 57493.83783891926, 57597.0, 57627.0, 57647.847043059744, 57791.37668986471, 15648.530544083696, 15838.683226335408, 15847.049177049414, 15902.522924312289, 15917.681646367007, 12307.0, 12311.19977201479, 12371.69070773238, 12378.319192444502, 12393.938030309791, 14194.503192388216, 14553.708925821424, 14829.703405932038, 14879.776803347959, 14913.850861491463, 5938.984808523549, 6046.576739628272, 6110.938890611126, 6117.877642447126, 6130.0, 845.8139209373928, 886.3396769406833, 935.8970513243673, 972.7762614598682, 972.9854052189223, 28941.0, 29078.563821542695, 29503.85248073746, 29876.253093672833, 29882.954096606514, 982.5922242269521, 1054.2462139570243, 1063.7819247054335, 1121.2039451989017, 1127.3179726265655, 15036.323365448581, 15135.394584216729, 15175.544733658007, 15383.923125381116, 15575.844241557666, 598116.0, 598744.0, 599190.0, 601626.0, 603257.0, 55578.16632750512, 55793.163102553495, 55886.441135588124, 56054.719726401105, 56062.71968640131, 1303.1008604063165, 1364.454218312663, 1366.7403193393025, 1370.8766211040854, 1375.1061809823696, 28180.43639127165, 28773.518885090445, 29136.8345266187, 29730.55404168896, 29814.0, 39921.0, 47473.0, 47917.28124078211, 47939.28091078567, 47946.5205347942, 563432.0, 567675.0, 567950.0, 568102.0, 568146.0, 37920.620793791706, 38340.61659383371, 38755.41866872056, 38791.284610077026, 38799.80600096982, 44676.55323446854, 45172.0, 46096.308555372365, 46293.0, 46417.071658567314, 37892.43161352527, 38155.42766858444, 38397.51602087186, 38990.6100938987, 39215.607843922335, 36515.817420912725, 36699.63300366962, 37768.62231377651, 37829.0, 38030.049248769, 36471.81764091163, 37096.814515927246, 37098.0, 37110.54673439096, 37384.0, 32147.517787232744, 33371.33257334888, 33460.33079338351, 33535.66464335325, 33695.494567582, 21984.670229946885, 24347.634785477876, 24975.0, 25445.23664290074, 25559.744402555738], "value": 19478.205327423155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.6798881007095, 356.62198070045747, 369.6045231602185, 382.74356181358496, 402.51697962445076, 15240.314185861635, 15657.765133523006, 16615.833841661595, 21049.36851894442, 21231.6815247771, 17009.0, 19395.806041939577, 20216.0, 20697.482562935933, 20947.162113515442, 5456.208849716789, 5678.517326027282, 5963.55273354498, 5964.1650168976375, 5973.729982606604, 4807.759612019402, 5582.888342233153, 5925.229720136398, 6174.259088909337, 6176.135341052256, 5838.503727183194, 6070.696465176746, 6118.847028824271, 6119.785807496739, 6127.938720612781, 6054.606450580698, 6113.419225173601, 6119.816405507842, 6121.234845644294, 6121.571489995725, 5122.667026643257, 5254.8160814371695, 5316.707581083039, 5320.441353657849, 5333.546648534879, 25795.355116122246, 26134.477310453876, 26233.606495902575, 26448.0, 26650.866745666342, 2074.263636409083, 2273.6703178039256, 2299.9310020699404, 2347.354477518679, 2418.987905060481, 14892.62768430787, 15409.537713868602, 15606.921965390215, 15819.52541423759, 15987.360505579763, 1869.9719504207449, 1907.075068591732, 1923.6152769446167, 1952.5509132899372, 1956.7358406615067, 124912.0, 125808.0, 126904.0, 130078.34960825136, 131060.10229539694, 10427.530761115768, 10565.524551395205, 11127.0, 11133.332000080021, 11280.32318060919, 13952.372143253375, 13956.2324072177, 13956.441742330397, 13960.650983725489, 13967.092139010932, 8326.750197494084, 8600.827983440297, 8619.0, 8751.299896008304, 8753.0, 8627.309815214769, 8649.783755406039, 8654.48073115615, 8857.822843543094, 8880.51157186361, 5933.762649494059, 6612.603243805387, 6718.294579069225, 6718.7312507499155, 6768.255491895888, 1591.7214487464648, 1615.4830454254525, 1683.8568721658796, 1748.606563523197, 1809.0, 916.5921165081608, 944.5891037398753, 1016.7407311135613, 1022.3916769522123, 1028.3624153025173, 20849.478763030744, 21500.452425349955, 22608.434789130402, 22644.433889152904, 22690.886545567166, 951.2960409297209, 960.1262850805733, 964.8745663063756, 968.7696625285847, 980.9607615695293, 10549.578016879239, 10908.890911090946, 11604.0, 12047.638570842888, 12172.2696638202, 596752.0, 601400.0, 611930.0, 614311.0, 614689.0, 93510.0, 114243.0, 117447.0, 137412.0, 144851.0, 965.5027660754857, 968.2447690801046, 980.8136454073704, 1014.9949250253701, 1016.0, 15556.68886622284, 19268.903655481634, 19800.603987919872, 19801.30695425653, 19884.304049358205, 38015.0, 49491.25763113484, 52831.71682831686, 57589.71205143948, 59227.223183304566, 61497.692511537156, 71825.92261116192, 76423.8536421943, 79893.4021319582, 81091.0, 6998.580085194904, 7256.346928776436, 7292.781216563511, 7491.550506969599, 7953.9602301990435, 8930.419522731001, 12849.0, 12849.421776019915, 13006.024548158737, 13237.602871913858, 10825.837612435977, 11227.989480946753, 11424.714382140513, 11431.59989400367, 11479.483423245807, 9337.53312334367, 10630.362178269328, 10936.179786516203, 11132.38771867555, 11338.376389298668, 11116.499757511094, 11325.433728313716, 11351.240557713567, 11381.601643942422, 11483.770324593293, 7185.964070179824, 7419.777406677808, 7443.069616297963, 7549.7357592483995, 7651.579163146081, 9367.484788336707, 10388.065074143364, 10414.843777343194, 10431.634892778717, 11118.277311974696], "value": 9669.543129226931, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.6470447092695, 1518.2181176694, 1628.9737465396797, 1687.5021868548777, 1850.213659194842, 8313.792155196115, 8858.379913406065, 8876.556172191396, 8889.888763904512, 8903.643854245838, 7778.222177782219, 7990.0, 7997.360211183106, 8371.91628083719, 8638.913610863889, 2303.0557471436714, 2334.323046316566, 2347.3310106619615, 2347.6054424487015, 2352.0, 2122.8620139690947, 2159.902804373807, 2345.2377977157407, 2357.257463898875, 2359.6224604063354, 2321.5008773113777, 2335.322756400642, 2342.1568235435316, 2347.2019513365453, 2352.752960939102, 2324.23300310897, 2325.9651105233434, 2326.3951372643064, 2330.2892617751577, 2333.3583264602203, 2303.332033710222, 2332.346942856003, 2334.334714606329, 2337.625979843234, 2341.730700969393, 8610.182032706945, 8816.779580510474, 8821.338399620054, 8822.823543529094, 8825.07336729647, 5121.359830021247, 5279.1817268323475, 5284.6564973277, 5286.841394758163, 5293.894122117575, 3451.81015044175, 3548.1307079765365, 3685.852565897361, 3687.4284485904727, 3694.4273637585948, 1088.646189988257, 1089.9455027248684, 1092.0771947704177, 1111.1610733895857, 1114.1977776001265, 11420.972112509913, 11538.250013749079, 11558.479868405942, 11567.76864462706, 11598.594049208237, 4467.374567560479, 4532.524084971096, 4719.268513380432, 4730.455997560256, 4730.550597693214, 9920.503974801231, 9939.707837981161, 9942.502874856229, 9951.601935922627, 9977.700668979942, 5285.101532739443, 5294.973525132426, 5296.09966305729, 5297.920531192035, 5299.12564426873, 4304.461942257218, 4338.305871060616, 4348.086901750605, 4844.297576851337, 4859.659823812299, 3796.9430458543143, 3839.308924393636, 3905.1994341159993, 3933.8033098344968, 3968.226195891831, 1256.849178098634, 1257.9748405031849, 1261.375619068567, 1275.6810797300675, 1275.7002104505434, 848.4612271207704, 852.3564708644933, 890.9109089091169, 908.68650315641, 932.1098351074843, 3865.729398942103, 5225.581953443715, 5513.724313784375, 5928.347881733092, 6001.789937352171, 891.3136884598823, 935.1910597333258, 958.152035448619, 976.8241716490958, 983.1348413396308, 3592.2995015972156, 3902.3951287550476, 3965.0682089708894, 3972.801359931992, 3980.2636512245326, 9629.32594718363, 10281.845772313422, 10419.270651054354, 10576.52405641748, 10585.0, 10528.578856845641, 10534.73663158412, 10549.894501055045, 10556.524956376828, 10565.471726413649, 7645.235476452311, 7979.281864632095, 8056.919430805734, 8157.510549366938, 8164.428490005643, 5621.578381621313, 5842.853928651818, 5895.644001879506, 5896.410358964241, 5917.289925209003, 9727.027297270217, 9993.10062094415, 10007.349522281029, 10010.499475026365, 10046.648367307109, 9660.806783864424, 9929.056739609725, 10032.64885728996, 10120.240981926532, 10161.748240562949, 6988.37104660583, 7221.31397517235, 7229.0, 7420.295071968154, 7585.50694204897, 8055.476394034369, 8367.748967530984, 8367.916320836957, 8459.98480182382, 8466.915330846612, 7341.0, 7365.631718413951, 7543.283388078124, 7655.119661238806, 7678.232176782277, 7196.136463624399, 7325.597092159769, 7328.853422931405, 7496.475246732676, 7510.39916806665, 6200.100985357189, 6806.523543351917, 6855.451563874978, 7022.894656580053, 7026.0, 4893.363862697826, 4948.208286674115, 4967.180415231446, 5004.1492946198505, 5047.343845300087, 3663.5420572428447, 4080.8979775504663, 4861.546421499861, 4965.900681986413, 5159.871003224949], "value": 4527.839459571736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.2304731898941, 301.81890865480716, 309.44300259532844, 314.73876682353637, 318.92505261263585, 4820.879478013043, 5103.489651034894, 5210.791568337267, 5304.575633949285, 5333.519983201511, 4886.218205087187, 5072.923906141411, 5143.588512918966, 5159.432462429129, 5178.8606506568585, 3513.7540372173958, 3811.6378944000276, 3969.8412063517426, 3984.900377490557, 4011.638952494275, 3034.679914237303, 3725.627437256266, 3963.8414463421427, 4021.9597804022023, 4028.274910516106, 3884.009577557719, 3892.06590418299, 3928.5874983126787, 3931.9213615727667, 3942.8619998300064, 3315.6352801192093, 3354.4465163248033, 3898.9805050974705, 3937.8818635440985, 3951.044233104603, 2842.332051967786, 3143.695366422932, 3175.903903423752, 3266.3304022675534, 3409.7613167078316, 5089.338386009832, 5091.363579552556, 5099.286099946011, 5103.668261563023, 5126.948730512721, 3836.7889766062854, 4406.788133263346, 4547.45430548333, 4591.862244132682, 4597.563231493003, 5268.0, 5419.458054194549, 5555.388907220203, 5562.7774889004395, 5580.832575022715, 3442.416488415332, 3726.9254614907823, 3763.924721505582, 3766.6986641068925, 3769.886903392875, 4300.720453170566, 5788.739506722165, 5803.314895041679, 5809.854753631151, 5859.824205273849, 3147.984260078685, 3397.3545026444895, 3665.6700896919406, 3837.597052309523, 3924.548676902136, 3872.9225415491533, 3874.535055793323, 3895.7857317847224, 3905.33609286422, 3920.843166273317, 4535.4103966484145, 4547.9279720035665, 4550.431196100488, 4554.521775213621, 4590.6557008223845, 4491.955080449219, 4871.124617022472, 5603.187537806995, 5615.382307946123, 5665.883763929822, 1240.2000709542294, 1313.8620444853343, 1322.3983087695076, 1336.692560711042, 1339.1964821107258, 704.0178950364214, 805.8791181322848, 815.502543448496, 819.2299238715589, 831.8918540589684, 4035.2131334389514, 4260.233158031522, 4288.935665965013, 4336.0, 4350.912981740347, 4060.0, 4209.3896385024, 4541.863744087683, 4654.720716757005, 4691.1555919934735, 3718.2710039831068, 4182.832686692559, 4292.647815937969, 4309.0, 4309.836344187114, 2033.8102210207194, 2222.8888555572157, 2364.8294094423372, 2506.8495890246277, 2527.721950585434, 4121.464209652786, 4525.389072475239, 4772.780656994514, 4882.607522314041, 4940.975295123573, 4516.119356725473, 4817.325574419584, 4834.6374021948495, 4835.323054772335, 4850.83022094225, 4366.5679335474515, 4748.477667456577, 5326.866828329323, 5423.29497165366, 5711.057675483665, 4753.668972687653, 5710.543156547549, 5731.56106336195, 5816.5055970243, 5833.941660583339, 5251.448597897166, 5742.339630942328, 5761.942380576308, 5762.954151276236, 5768.336641286138, 5143.665661731976, 5359.330083739533, 5863.384344643751, 5865.706714664165, 5917.704114794329, 3755.2114056047444, 3882.6893848491486, 3902.2195560888504, 3930.76415415076, 3960.4455376247925, 5257.78968841242, 5325.009364464977, 5575.303087114111, 5749.741261643152, 5796.971015144897, 5584.0, 5592.86017849557, 5608.766071464272, 5612.4668156526695, 5660.886782264414, 4903.828366007173, 5228.947710522846, 5567.0, 5600.35595906476, 5609.80365687199, 4589.609883159968, 5474.644148130359, 5492.642978206404, 5526.148740172087, 5538.584606154474, 5054.924176137288, 5187.98834227322, 5667.971660141673, 5688.070643618623, 5693.345265294379, 4581.198290299118, 4776.617870570415, 5217.791288348423, 5408.404520666491, 5456.7544460498575], "value": 3883.0085624559756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6402390577607, 766.7738017284897, 781.7570063598877, 819.7167621187896, 821.7452589697198, 15161.545153645395, 16565.66868662626, 17174.0, 17439.825601743978, 17506.737398939025, 15804.84195158048, 15904.204789760524, 16012.759808602852, 16066.839331606681, 16074.678506429864, 843.493903657805, 864.2135656552539, 873.995630021849, 874.4359887872318, 875.2254254984321, 652.4291245160484, 678.3453966921919, 865.7835541114721, 870.4820631724114, 871.4553404122423, 740.3484933258752, 879.1647934462254, 908.0148039377251, 914.2457472585144, 918.6279556779482, 893.9597718102701, 894.6823877523483, 896.9416987895798, 897.8114595934861, 901.2069378946551, 534.4815528936925, 663.383053760003, 664.1764212376667, 665.490899461912, 666.7333066773281, 12517.687057823536, 12761.489540418464, 12771.361431928459, 12771.808422873664, 14812.111273323528, 13701.314934253347, 14260.358283877147, 14375.209363485004, 14424.639384015378, 14852.480163194236, 11468.541258349656, 11817.527298908033, 11900.880991190064, 11982.820257696141, 12374.938125309316, 3736.4768932349493, 3805.8667946622013, 3810.542734871833, 3875.399313106445, 3962.5244970603712, 95862.0, 97516.0, 101261.4936925318, 124652.0, 126058.0, 10920.50857711405, 10930.945345273223, 11014.229003969805, 11104.944475277573, 11408.372539510407, 21609.027593758317, 21614.56770864574, 21627.459313516974, 21627.783722162578, 21657.67513487299, 7768.339691126204, 7806.0, 7839.804004899923, 7914.366850651934, 7922.128565857751, 4237.8304867805555, 4330.458692663417, 4334.739915605074, 4336.046069864625, 4446.466424029137, 3564.411872041136, 3728.6457786510236, 3730.0861288984374, 3734.79458629778, 3737.5141231639714, 688.9414399776075, 723.0636325957897, 723.5513981331608, 725.3508110241304, 725.3870479444861, 536.8174820561028, 540.7377421950351, 565.1381642994385, 594.3699678340972, 671.7480944645757, 8521.57392130391, 9371.578278977462, 9491.810163796823, 9519.428834269966, 9668.564914578861, 514.6603241860354, 543.098456562105, 585.9970700146472, 642.6915080761261, 686.807693845724, 4175.937360939588, 4622.006268652256, 4652.116097941381, 4692.976535117303, 4710.317004034464, 145799.0, 156852.21573892285, 157492.3134608174, 158370.0, 159521.0, 86419.56790216008, 88180.0, 88557.55721221352, 91663.0, 99782.0, 88677.24550299591, 95524.0, 113135.86864131418, 117433.0, 120964.39517802355, 8718.258947989492, 8934.910650893407, 8953.059928707653, 8957.910420895707, 9011.316259678171, 56623.392204598786, 59422.0, 59571.0, 63283.6835815818, 64326.67836660787, 71641.64179179071, 95149.0, 100134.4993275029, 100540.44865737743, 103596.44605330775, 11445.370504622326, 11656.88343116558, 11784.941075294568, 11934.641960741192, 12375.504979800708, 12799.872001279868, 13105.672358191121, 13159.725673392611, 13575.0, 13651.590452286448, 11625.825612615648, 11838.112141589243, 12018.33899135521, 12043.939780301042, 12466.127371083938, 11941.204872051352, 12126.0, 12174.0, 12180.208286461351, 12576.371181440709, 11838.763224735629, 12128.090393220367, 12289.938550307192, 12304.200226985216, 12537.811932820832, 9899.604015839574, 10159.238057145596, 10330.121939635215, 10332.741681457723, 10450.42522661261, 9794.26543009263, 10133.847992280269, 10168.440735759605, 10201.234907381828, 10234.6417875374], "value": 7581.504729934277, "unit": "score"}], "name": "dromaeo_css", "value": 7228.966677664258, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 112.0, 111.0, 112.0, 113.0, 111.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 143.0, 139.0, 148.0, 113.0, 113.0, 111.0, 115.0, 143.0, 110.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 184.0, 185.0, 184.0, 182.0, 184.0, 181.0, 181.0, 184.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 88.0, 63.0, 72.0, 82.0, 82.0, 83.0, 58.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 94.0, 71.0, 82.0, 100.0, 130.0, 78.0, 68.0, 90.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 85.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 151.0, 94.0, 94.0, 93.0, 94.0, 107.0, 150.0, 116.0, 94.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 122.0, 140.0, 131.0, 116.0, 84.0, 84.0, 83.0, 84.0, 83.0], "value": 102.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 52.0, 52.0, 53.0, 53.0, 54.0, 55.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 64.0, 85.0, 111.0, 107.0, 84.0, 71.0, 71.0, 70.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 86.0, 87.0, 83.0, 87.0, 88.0, 87.0, 86.0, 91.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 160.0, 155.0, 157.0, 152.0, 148.0, 152.0, 154.0, 185.0, 147.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 171.0, 171.0, 171.0, 173.0, 171.0, 170.0, 171.0, 171.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1500.3999999999999, "alertThreshold": 2.0}]} 09:08:26 INFO - Return code: 0 09:08:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:26 INFO - # TBPL SUCCESS # 09:08:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:26 INFO - 2016-10-06 09:08:26.744 screenresolution[1666:10275] starting screenresolution argv=screenresolution get 09:08:26 INFO - 2016-10-06 09:08:26.747 screenresolution[1666:10275] Display 0: 1600x1200x32@60 09:08:26 INFO - 2016-10-06 09:08:26.753 screenresolution[1667:10278] starting screenresolution argv=screenresolution list 09:08:26 INFO - Available Modes on Display 0 09:08:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:26 INFO - Intel Iris: 09:08:26 INFO - Chipset Model: Intel Iris 09:08:26 INFO - Type: GPU 09:08:26 INFO - Bus: Built-In 09:08:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:26 INFO - Vendor: Intel (0x8086) 09:08:26 INFO - Device ID: 0x0a2e 09:08:26 INFO - Revision ID: 0x0009 09:08:26 INFO - Displays: 09:08:26 INFO - Display: 09:08:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:26 INFO - Display Serial Number: 1600x1200 60 09:08:26 INFO - Main Display: Yes 09:08:26 INFO - Mirror: Off 09:08:26 INFO - Online: Yes 09:08:26 INFO - Rotation: Supported 09:08:27 INFO - Return code: 0 09:08:27 INFO - Running post-action listener: _resource_record_post_action 09:08:27 INFO - [mozharness: 2016-10-06 16:08:27.001918Z] Finished run-tests step (success) 09:08:27 INFO - Running post-run listener: _resource_record_post_run 09:08:27 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 33037312; Write bytes: 709531648; Read time: 310; Write time: 2154 09:08:27 INFO - TinderboxPrint: CPU usage
53.5% 09:08:27 INFO - TinderboxPrint: I/O read bytes / time
33,037,312 / 310 09:08:27 INFO - TinderboxPrint: I/O write bytes / time
709,531,648 / 2,154 09:08:27 INFO - TinderboxPrint: CPU idle
2,255.3 (46.5%) 09:08:27 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 09:08:27 INFO - TinderboxPrint: CPU user
1,628.5 (33.6%) 09:08:27 INFO - TinderboxPrint: Swap in / out
436,719,616 / 0 09:08:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402295296; Write bytes: 396576256; Read time: 29680; Write time: 696 09:08:27 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30948352; Write bytes: 297955840; Read time: 288; Write time: 1418 09:08:27 INFO - Running post-run listener: _upload_blobber_files 09:08:27 INFO - Blob upload gear active. 09:08:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:27 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 09:08:27 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:27 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:28 INFO - (blobuploader) - INFO - Done attempting. 09:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:29 INFO - (blobuploader) - INFO - Done attempting. 09:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:32 INFO - (blobuploader) - INFO - Done attempting. 09:08:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:32 INFO - Return code: 0 09:08:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be3d60199fd779708841965ca425070bb4a0935681508ab8dbfb0e32c9f7e9e813f1121a1e22385fb95e57372e7f9610f4b444d483f27c4b405a6561c2a94cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df7c0c34ec503b52786dad109327918f5726a3e0009b3bc22b7c089f5b17e46c0a05a58566de5a9489dd66de27f2895e2c39166ab47e82ae4a89d23509d7a88b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b5e6f7c9a8db158d2e76d3500f01bb6cb86879bd6f3f9fdd6ece2ea7002a41a437c3b385a35ecbb046b7987740cdaad2577229fdba9383a3b0633cf114ed99d"} 09:08:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:32 INFO - Contents: 09:08:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be3d60199fd779708841965ca425070bb4a0935681508ab8dbfb0e32c9f7e9e813f1121a1e22385fb95e57372e7f9610f4b444d483f27c4b405a6561c2a94cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df7c0c34ec503b52786dad109327918f5726a3e0009b3bc22b7c089f5b17e46c0a05a58566de5a9489dd66de27f2895e2c39166ab47e82ae4a89d23509d7a88b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b5e6f7c9a8db158d2e76d3500f01bb6cb86879bd6f3f9fdd6ece2ea7002a41a437c3b385a35ecbb046b7987740cdaad2577229fdba9383a3b0633cf114ed99d"} 09:08:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:32 INFO - Copying logs to upload dir... 09:08:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.713061 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-06 09:08:32.374602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 09:08:32.379232) ========= 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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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/Fx-Team/sha512/6be3d60199fd779708841965ca425070bb4a0935681508ab8dbfb0e32c9f7e9e813f1121a1e22385fb95e57372e7f9610f4b444d483f27c4b405a6561c2a94cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df7c0c34ec503b52786dad109327918f5726a3e0009b3bc22b7c089f5b17e46c0a05a58566de5a9489dd66de27f2895e2c39166ab47e82ae4a89d23509d7a88b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b5e6f7c9a8db158d2e76d3500f01bb6cb86879bd6f3f9fdd6ece2ea7002a41a437c3b385a35ecbb046b7987740cdaad2577229fdba9383a3b0633cf114ed99d"} build_url:https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/X2K1pLzuSSunKYht-3xNDw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be3d60199fd779708841965ca425070bb4a0935681508ab8dbfb0e32c9f7e9e813f1121a1e22385fb95e57372e7f9610f4b444d483f27c4b405a6561c2a94cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df7c0c34ec503b52786dad109327918f5726a3e0009b3bc22b7c089f5b17e46c0a05a58566de5a9489dd66de27f2895e2c39166ab47e82ae4a89d23509d7a88b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b5e6f7c9a8db158d2e76d3500f01bb6cb86879bd6f3f9fdd6ece2ea7002a41a437c3b385a35ecbb046b7987740cdaad2577229fdba9383a3b0633cf114ed99d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 09:08:32.411956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:08:32.412296) ========= 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.gVUUMGhnJO/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.jTfYWnEpcw/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005225 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:08:32.460824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 09:08:32.461144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 09:08:32.461525) ========= ========= Total master_lag: 0.34 =========