builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0236 starttime: 1477756009.3 results: success (0) buildid: 20161029062222 builduid: 48f0ddd6a6e34dbfb32bbf671316580f revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.303475) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.303945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.304221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.327441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.327758) ========= 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.798QYNhcMw/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.8c5UNMmsA5/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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-29 08:46:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2016-10-29 08:46:49 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.482343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.482660) ========= 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.798QYNhcMw/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.8c5UNMmsA5/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.019256 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:49.531422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-29 08:46:49.531807) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --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 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.798QYNhcMw/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.8c5UNMmsA5/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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-29 08:46:49,614 truncating revision to first 12 chars 2016-10-29 08:46:49,614 Setting DEBUG logging. 2016-10-29 08:46:49,614 attempt 1/10 2016-10-29 08:46:49,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b170b39ed6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 08:46:51,543 unpacking tar archive at: fx-team-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.195636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-29 08:46:51.750011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:51.750348) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:51.750730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:51.750995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 08:46:51.769708) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-29 08:46:51.770107) ========= /tools/buildbot/bin/python -u 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', '-u', '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.798QYNhcMw/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.8c5UNMmsA5/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:46:51 INFO - MultiFileLogger online at 20161029 08:46:51 in /builds/slave/test 08:46:51 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:46:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:51 INFO - {'append_to_log': False, 08:46:51 INFO - 'base_work_dir': '/builds/slave/test', 08:46:51 INFO - 'blob_upload_branch': 'Fx-Team', 08:46:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:51 INFO - 'branch': 'Fx-Team', 08:46:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:51 INFO - 'config_files': ('talos/mac_config.py',), 08:46:51 INFO - 'default_actions': ('clobber', 08:46:51 INFO - 'read-buildbot-config', 08:46:51 INFO - 'download-and-extract', 08:46:51 INFO - 'populate-webroot', 08:46:51 INFO - 'create-virtualenv', 08:46:51 INFO - 'install', 08:46:51 INFO - 'run-tests'), 08:46:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:51 INFO - 'download_minidump_stackwalk': True, 08:46:51 INFO - 'download_symbols': 'ondemand', 08:46:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:51 INFO - 'installer_path': 'installer.exe', 08:46:51 INFO - 'log_level': 'info', 08:46:51 INFO - 'log_name': 'talos', 08:46:51 INFO - 'log_to_console': True, 08:46:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:46:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:46:51 INFO - 'opt_config_files': (), 08:46:51 INFO - 'pip_index': False, 08:46:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:46:51 INFO - 'cmd': ('bash', 08:46:51 INFO - '-c', 08:46:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:46:51 INFO - 'enabled': True, 08:46:51 INFO - 'halt_on_failure': False, 08:46:51 INFO - 'name': 'check_screen_resolution'},), 08:46:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:46:51 INFO - 'cmd': ('bash', 08:46:51 INFO - '-c', 08:46:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:46:51 INFO - 'enabled': True, 08:46:51 INFO - 'halt_on_failure': False, 08:46:51 INFO - 'name': 'check_screen_resolution'},), 08:46:51 INFO - 'run_cmd_checks_enabled': True, 08:46:51 INFO - 'sps_profile': False, 08:46:51 INFO - 'sps_profile_interval': 0, 08:46:51 INFO - 'suite': 'dromaeojs', 08:46:51 INFO - 'system_bits': '32', 08:46:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:51 INFO - 'title': 't-yosemite-r7-0236', 08:46:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:51 INFO - 'use_talos_json': True, 08:46:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:51 INFO - 'work_dir': 'build'} 08:46:51 INFO - [mozharness: 2016-10-29 15:46:51.972161Z] Running clobber step. 08:46:51 INFO - Running pre-action listener: _resource_record_pre_action 08:46:51 INFO - Running main action method: clobber 08:46:51 INFO - rmtree: /builds/slave/test/build 08:46:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:52 INFO - Running post-action listener: _resource_record_post_action 08:46:52 INFO - [mozharness: 2016-10-29 15:46:52.143046Z] Finished clobber step (success) 08:46:52 INFO - [mozharness: 2016-10-29 15:46:52.143167Z] Running read-buildbot-config step. 08:46:52 INFO - Running pre-action listener: _resource_record_pre_action 08:46:52 INFO - Running main action method: read_buildbot_config 08:46:52 INFO - Using buildbot properties: 08:46:52 INFO - { 08:46:52 INFO - "project": "", 08:46:52 INFO - "product": "firefox", 08:46:52 INFO - "script_repo_revision": "production", 08:46:52 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:46:52 INFO - "repository": "", 08:46:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:46:52 INFO - "buildid": "20161029062222", 08:46:52 INFO - "pgo_build": "False", 08:46:52 INFO - "basedir": "/builds/slave/test", 08:46:52 INFO - "buildnumber": 185, 08:46:52 INFO - "slavename": "t-yosemite-r7-0236", 08:46:52 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:46:52 INFO - "platform": "yosemite_r7", 08:46:52 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:46:52 INFO - "branch": "fx-team", 08:46:52 INFO - "repo_path": "integration/fx-team", 08:46:52 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 08:46:52 INFO - "stage_platform": "macosx64", 08:46:52 INFO - "builduid": "48f0ddd6a6e34dbfb32bbf671316580f", 08:46:52 INFO - "slavebuilddir": "test" 08:46:52 INFO - } 08:46:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:46:52 INFO - Running post-action listener: _resource_record_post_action 08:46:52 INFO - [mozharness: 2016-10-29 15:46:52.146551Z] Finished read-buildbot-config step (success) 08:46:52 INFO - [mozharness: 2016-10-29 15:46:52.146670Z] Running download-and-extract step. 08:46:52 INFO - Running pre-action listener: _resource_record_pre_action 08:46:52 INFO - Running main action method: download_and_extract 08:46:52 INFO - mkdir: /builds/slave/test/build/tests 08:46: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:46:52 INFO - trying https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:46:52 INFO - Downloading https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/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:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/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:46:53 INFO - Downloaded 1199 bytes. 08:46:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:46:53 INFO - Using the following test package requirements: 08:46:53 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:46:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:46:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:46:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'jsshell-mac.zip'], 08:46:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:46:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:46:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:46:53 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:46:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:46:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:46:53 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:46:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:46:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:46:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:46:53 INFO - Fetch https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:46:54 INFO - Http code: 200 08:46:54 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 08:46:54 INFO - x-amz-cf-id: Tk56jBzlgw1W4wsdbM98I4JzvYqju9XLuObdvK0h5dfKXo2jZny9mg== 08:46:54 INFO - x-amz-version-id: iFFlg968oCwsNrN69GZNHn_hCRh246uR 08:46:54 INFO - Expected file size: 16391720 08:46:54 INFO - Obtained file size: 16391720 08:47:00 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:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:47:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:47:00 INFO - Fetch https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:47:01 INFO - Http code: 200 08:47:01 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 08:47:01 INFO - x-amz-cf-id: Jba9LG9Mb9dYR5UnXcdhna2H6wksqLVNIIan0uU4rUEAVMkB2UciNg== 08:47:01 INFO - x-amz-version-id: iFFlg968oCwsNrN69GZNHn_hCRh246uR 08:47:01 INFO - Expected file size: 16391720 08:47:01 INFO - Obtained file size: 16391720 08:47:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:47:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:47:08 INFO - Fetch https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:47:09 INFO - Http code: 200 08:47:09 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 08:47:09 INFO - x-amz-cf-id: 5dvrCm8OoIvcjJgEqqERC7br1uwF0GK2hYT9VvLq9E8c0O890_HUJQ== 08:47:09 INFO - x-amz-version-id: FpJMwZu6O67LvwUomP00TKSlWbxB5525 08:47:09 INFO - Expected file size: 14409038 08:47:09 INFO - Obtained file size: 14409038 08:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:09 INFO - trying https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:47:09 INFO - Downloading https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/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:12 INFO - Downloaded 112026591 bytes. 08:47:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:47:12 INFO - mkdir: /builds/slave/test/properties 08:47:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:12 INFO - Contents: 08:47:12 INFO - build_url:https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:47:13 INFO - Running post-action listener: _resource_record_post_action 08:47:13 INFO - Running post-action listener: set_extra_try_arguments 08:47:13 INFO - [mozharness: 2016-10-29 15:47:13.335279Z] Finished download-and-extract step (success) 08:47:13 INFO - [mozharness: 2016-10-29 15:47:13.335401Z] Running populate-webroot step. 08:47:13 INFO - Running pre-action listener: _resource_record_pre_action 08:47:13 INFO - Running main action method: populate_webroot 08:47:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:13 INFO - '--tppagecycles', 08:47:13 INFO - '7'], 08:47:13 INFO - 'tests': ['tsvgm']}}, 08:47:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:47:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:47:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['damp', 'tps']}, 08:47:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'tests': ['damp', 'tps']}, 08:47:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['dromaeo_dom']}, 08:47:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['basic_compositor_video']}, 08:47:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:47:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['a11yr', 08:47:13 INFO - 'ts_paint', 08:47:13 INFO - 'tpaint', 08:47:13 INFO - 'sessionrestore', 08:47:13 INFO - 'sessionrestore_no_auto_restore', 08:47:13 INFO - 'tabpaint']}, 08:47:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:47:13 INFO - 'ts_paint', 08:47:13 INFO - 'tpaint', 08:47:13 INFO - 'sessionrestore', 08:47:13 INFO - 'sessionrestore_no_auto_restore', 08:47:13 INFO - 'tabpaint']}, 08:47:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:47:13 INFO - 'ts_paint', 08:47:13 INFO - 'tpaint', 08:47:13 INFO - 'sessionrestore', 08:47:13 INFO - 'sessionrestore_no_auto_restore', 08:47:13 INFO - 'tabpaint']}, 08:47:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:47:13 INFO - 'ts_paint', 08:47:13 INFO - 'tpaint', 08:47:13 INFO - 'sessionrestore', 08:47:13 INFO - 'sessionrestore_no_auto_restore', 08:47:13 INFO - 'tabpaint']}, 08:47:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['a11yr', 08:47:13 INFO - 'ts_paint', 08:47:13 INFO - 'tpaint', 08:47:13 INFO - 'sessionrestore', 08:47:13 INFO - 'sessionrestore_no_auto_restore', 08:47:13 INFO - 'tabpaint']}, 08:47:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['a11yr', 08:47:13 INFO - 'ts_paint', 08:47:13 INFO - 'tpaint', 08:47:13 INFO - 'sessionrestore', 08:47:13 INFO - 'sessionrestore_no_auto_restore', 08:47:13 INFO - 'tabpaint']}, 08:47:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['tsvgx', 08:47:13 INFO - 'tsvgr_opacity', 08:47:13 INFO - 'tart', 08:47:13 INFO - 'tscrollx', 08:47:13 INFO - 'cart']}, 08:47:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:47:13 INFO - 'tsvgr_opacity', 08:47:13 INFO - 'tart', 08:47:13 INFO - 'tscrollx', 08:47:13 INFO - 'cart']}, 08:47:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'talos_options': ['--disable-e10s'], 08:47:13 INFO - 'tests': ['tp5o']}, 08:47:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'tests': ['tp5o']}, 08:47:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'talos_options': ['--disable-e10s', 08:47:13 INFO - '--xperf_path', 08:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:13 INFO - 'tests': ['tp5n']}, 08:47:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:13 INFO - 'talos_options': ['--xperf_path', 08:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:13 INFO - 'tests': ['tp5n']}}, 08:47:13 INFO - 'talos.zip': {'path': '', 08:47:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:13 INFO - Running post-action listener: _resource_record_post_action 08:47:13 INFO - [mozharness: 2016-10-29 15:47:13.354357Z] Finished populate-webroot step (success) 08:47:13 INFO - [mozharness: 2016-10-29 15:47:13.354456Z] Running create-virtualenv step. 08:47:13 INFO - Running pre-action listener: _resource_record_pre_action 08:47:13 INFO - Running main action method: create_virtualenv 08:47:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:13 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:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:13 INFO - Using real prefix '/tools/python27' 08:47:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:17 INFO - Installing pip.................done. 08:47:17 INFO - Return code: 0 08:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:47:17 INFO - Reading from file tmpfile_stdout 08:47:17 INFO - Output received: 08:47:17 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:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:17 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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:17 INFO - 'HOME': '/Users/cltbld', 08:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:17 INFO - 'LOGNAME': 'cltbld', 08:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:17 INFO - 'MOZ_NO_REMOTE': '1', 08:47:17 INFO - 'NO_EM_RESTART': '1', 08:47:17 INFO - 'PAGER': '/bin/cat', 08:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:17 INFO - 'PWD': '/builds/slave/test', 08:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:17 INFO - 'SHELL': '/bin/bash', 08:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:17 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:17 INFO - 'USER': 'cltbld', 08:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:17 INFO - 'XPC_FLAGS': '0x0', 08:47:17 INFO - 'XPC_SERVICE_NAME': '0', 08:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:17 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:17 INFO - Cleaning up... 08:47:17 INFO - Return code: 0 08:47:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:47:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:17 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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:17 INFO - 'HOME': '/Users/cltbld', 08:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:17 INFO - 'LOGNAME': 'cltbld', 08:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:17 INFO - 'MOZ_NO_REMOTE': '1', 08:47:17 INFO - 'NO_EM_RESTART': '1', 08:47:17 INFO - 'PAGER': '/bin/cat', 08:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:17 INFO - 'PWD': '/builds/slave/test', 08:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:17 INFO - 'SHELL': '/bin/bash', 08:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:17 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:17 INFO - 'USER': 'cltbld', 08:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:17 INFO - 'XPC_FLAGS': '0x0', 08:47:17 INFO - 'XPC_SERVICE_NAME': '0', 08:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:17 INFO - Downloading/unpacking psutil>=3.1.1 08:47:17 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:17 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:17 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:17 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:17 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:17 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:21 INFO - Installing collected packages: psutil 08:47:21 INFO - Running setup.py install for psutil 08:47:21 INFO - building 'psutil._psutil_osx' extension 08:47:21 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:21 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:21 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:21 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:21 INFO - building 'psutil._psutil_posix' extension 08:47:21 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:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:47:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:47:21 INFO - ^ 08:47:21 INFO - 1 warning generated. 08:47:21 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:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:22 INFO - Successfully installed psutil 08:47:22 INFO - Cleaning up... 08:47:22 INFO - Return code: 0 08:47:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:22 INFO - 'HOME': '/Users/cltbld', 08:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:22 INFO - 'LOGNAME': 'cltbld', 08:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:22 INFO - 'MOZ_NO_REMOTE': '1', 08:47:22 INFO - 'NO_EM_RESTART': '1', 08:47:22 INFO - 'PAGER': '/bin/cat', 08:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:22 INFO - 'PWD': '/builds/slave/test', 08:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:22 INFO - 'SHELL': '/bin/bash', 08:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:22 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:22 INFO - 'USER': 'cltbld', 08:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:22 INFO - 'XPC_FLAGS': '0x0', 08:47:22 INFO - 'XPC_SERVICE_NAME': '0', 08:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:47:22 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:22 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:22 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:22 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:22 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:22 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:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:25 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:25 INFO - Installing collected packages: mozsystemmonitor 08:47:25 INFO - Running setup.py install for mozsystemmonitor 08:47:25 INFO - Successfully installed mozsystemmonitor 08:47:25 INFO - Cleaning up... 08:47:25 INFO - Return code: 0 08:47:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:25 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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:25 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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:25 INFO - 'HOME': '/Users/cltbld', 08:47:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:25 INFO - 'LOGNAME': 'cltbld', 08:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:25 INFO - 'MOZ_NO_REMOTE': '1', 08:47:25 INFO - 'NO_EM_RESTART': '1', 08:47:25 INFO - 'PAGER': '/bin/cat', 08:47:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:25 INFO - 'PWD': '/builds/slave/test', 08:47:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:25 INFO - 'SHELL': '/bin/bash', 08:47:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:25 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:25 INFO - 'USER': 'cltbld', 08:47:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:25 INFO - 'XPC_FLAGS': '0x0', 08:47:25 INFO - 'XPC_SERVICE_NAME': '0', 08:47:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:28 INFO - warning: no files found matching '*.txt' 08:47:28 INFO - no previously-included directories found matching 'build' 08:47:28 INFO - no previously-included directories found matching 'dist' 08:47:28 INFO - no previously-included directories found matching '.git*' 08:47:28 INFO - Installing collected packages: jsonschema, functools32 08:47:28 INFO - Running setup.py install for functools32 08:47:28 INFO - warning: no files found matching '*.txt' 08:47:28 INFO - no previously-included directories found matching 'build' 08:47:28 INFO - no previously-included directories found matching 'dist' 08:47:28 INFO - no previously-included directories found matching '.git*' 08:47:28 INFO - Successfully installed jsonschema functools32 08:47:28 INFO - Cleaning up... 08:47:28 INFO - Return code: 0 08:47:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:28 INFO - 'HOME': '/Users/cltbld', 08:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:28 INFO - 'LOGNAME': 'cltbld', 08:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:28 INFO - 'MOZ_NO_REMOTE': '1', 08:47:28 INFO - 'NO_EM_RESTART': '1', 08:47:28 INFO - 'PAGER': '/bin/cat', 08:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:28 INFO - 'PWD': '/builds/slave/test', 08:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:28 INFO - 'SHELL': '/bin/bash', 08:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:28 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:28 INFO - 'USER': 'cltbld', 08:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:28 INFO - 'XPC_FLAGS': '0x0', 08:47:28 INFO - 'XPC_SERVICE_NAME': '0', 08:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:47:29 INFO - Cleaning up... 08:47:29 INFO - Return code: 0 08:47:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:29 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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:29 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:29 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:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:29 INFO - 'HOME': '/Users/cltbld', 08:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:29 INFO - 'LOGNAME': 'cltbld', 08:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:29 INFO - 'MOZ_NO_REMOTE': '1', 08:47:29 INFO - 'NO_EM_RESTART': '1', 08:47:29 INFO - 'PAGER': '/bin/cat', 08:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:29 INFO - 'PWD': '/builds/slave/test', 08:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:29 INFO - 'SHELL': '/bin/bash', 08:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:29 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:29 INFO - 'USER': 'cltbld', 08:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:29 INFO - 'XPC_FLAGS': '0x0', 08:47:29 INFO - 'XPC_SERVICE_NAME': '0', 08:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:32 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:32 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:32 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:32 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:32 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:32 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:33 INFO - Downloading docopt-0.6.1.tar.gz 08:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:33 INFO - Running setup.py install for blobuploader 08:47:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:33 INFO - Running setup.py install for requests 08:47:33 INFO - Running setup.py install for docopt 08:47:33 INFO - Successfully installed blobuploader requests docopt 08:47:33 INFO - Cleaning up... 08:47:34 INFO - Return code: 0 08:47:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:34 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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:34 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:47:34 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:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:34 INFO - 'HOME': '/Users/cltbld', 08:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:34 INFO - 'LOGNAME': 'cltbld', 08:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:34 INFO - 'MOZ_NO_REMOTE': '1', 08:47:34 INFO - 'NO_EM_RESTART': '1', 08:47:34 INFO - 'PAGER': '/bin/cat', 08:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:34 INFO - 'PWD': '/builds/slave/test', 08:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:34 INFO - 'SHELL': '/bin/bash', 08:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:34 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:34 INFO - 'USER': 'cltbld', 08:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:34 INFO - 'XPC_FLAGS': '0x0', 08:47:34 INFO - 'XPC_SERVICE_NAME': '0', 08:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-qB4BVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-rmL2JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-hy0bL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-NZT995-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-mszpFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-Fe1blV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:34 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-H0bVnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-lZALDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-rCsDg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-eu5UL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-04PtGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-JFIirH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-FtLzYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-VnQiQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-YY2UaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:35 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-ZRuNSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:36 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-xIdRYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:36 INFO - Running setup.py install for manifestparser 08:47:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for mozcrash 08:47:36 INFO - Running setup.py install for mozdebug 08:47:36 INFO - Running setup.py install for mozdevice 08:47:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:36 INFO - Running setup.py install for mozfile 08:47:36 INFO - Running setup.py install for mozhttpd 08:47:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Running setup.py install for mozinfo 08:47:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Running setup.py install for mozInstall 08:47:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Running setup.py install for mozleak 08:47:37 INFO - Running setup.py install for mozlog 08:47:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Running setup.py install for moznetwork 08:47:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:37 INFO - Running setup.py install for mozprocess 08:47:37 INFO - Running setup.py install for mozprofile 08:47:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:38 INFO - Running setup.py install for mozrunner 08:47:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:38 INFO - Running setup.py install for mozscreenshot 08:47:38 INFO - Running setup.py install for moztest 08:47:38 INFO - Running setup.py install for mozversion 08:47:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:38 INFO - Cleaning up... 08:47:38 INFO - Return code: 0 08:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:38 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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:38 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:47:38 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:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:38 INFO - 'HOME': '/Users/cltbld', 08:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:38 INFO - 'LOGNAME': 'cltbld', 08:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:38 INFO - 'MOZ_NO_REMOTE': '1', 08:47:38 INFO - 'NO_EM_RESTART': '1', 08:47:38 INFO - 'PAGER': '/bin/cat', 08:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:38 INFO - 'PWD': '/builds/slave/test', 08:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:38 INFO - 'SHELL': '/bin/bash', 08:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:47:38 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:38 INFO - 'USER': 'cltbld', 08:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:38 INFO - 'XPC_FLAGS': '0x0', 08:47:38 INFO - 'XPC_SERVICE_NAME': '0', 08:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-7pCteS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-HE_7Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-wuRcTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-7ezRF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-WR_VwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-P2z9hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-XynSfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-vANHIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-kHDsAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:39 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:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:39 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-AqdMhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-9JeNnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-9Ojmrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-sCJDOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-rjla5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-xqBqYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-wte9d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:40 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:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:40 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-b0n9yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:43 INFO - Downloading blessings-1.6.tar.gz 08:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:43 INFO - Installing collected packages: blessings 08:47:43 INFO - Running setup.py install for blessings 08:47:43 INFO - Successfully installed blessings 08:47:43 INFO - Cleaning up... 08:47:43 INFO - Return code: 0 08:47:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:44 INFO - Reading from file tmpfile_stdout 08:47:44 INFO - Current package versions: 08:47:44 INFO - blessings == 1.6 08:47:44 INFO - blobuploader == 1.2.4 08:47:44 INFO - docopt == 0.6.1 08:47:44 INFO - functools32 == 3.2.3-2 08:47:44 INFO - jsonschema == 2.5.1 08:47:44 INFO - manifestparser == 1.1 08:47:44 INFO - mozInstall == 1.12 08:47:44 INFO - mozcrash == 0.17 08:47:44 INFO - mozdebug == 0.1 08:47:44 INFO - mozdevice == 0.48 08:47:44 INFO - mozfile == 1.2 08:47:44 INFO - mozhttpd == 0.7 08:47:44 INFO - mozinfo == 0.9 08:47:44 INFO - mozleak == 0.1 08:47:44 INFO - mozlog == 3.4 08:47:44 INFO - moznetwork == 0.27 08:47:44 INFO - mozprocess == 0.23 08:47:44 INFO - mozprofile == 0.28 08:47:44 INFO - mozrunner == 6.12 08:47:44 INFO - mozscreenshot == 0.1 08:47:44 INFO - mozsystemmonitor == 0.3 08:47:44 INFO - moztest == 0.7 08:47:44 INFO - mozversion == 1.4 08:47:44 INFO - psutil == 3.1.1 08:47:44 INFO - requests == 1.2.3 08:47:44 INFO - wsgiref == 0.1.2 08:47:44 INFO - Installing None 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', '-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 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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', '-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:47:44 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:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/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.8c5UNMmsA5/Listeners', 08:47:44 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 - 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 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:47:44 INFO - Cleaning up... 08:47:44 INFO - Return code: 0 08:47:44 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1048a0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104816570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ac1492c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, '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.798QYNhcMw/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.8c5UNMmsA5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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', 'jsonschema'] 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 jsonschema 08:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/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.8c5UNMmsA5/Listeners', 08:47:44 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:47:44 INFO - Cleaning up... 08:47:44 INFO - Return code: 0 08:47:44 INFO - Running post-action listener: _resource_record_post_action 08:47:44 INFO - Running post-action listener: _start_resource_monitoring 08:47:44 INFO - Starting resource monitoring. 08:47:44 INFO - [mozharness: 2016-10-29 15:47:44.601965Z] Finished create-virtualenv step (success) 08:47:44 INFO - [mozharness: 2016-10-29 15:47:44.602966Z] Running install step. 08:47:44 INFO - Running pre-action listener: _resource_record_pre_action 08:47:44 INFO - Running main action method: install 08:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:44 INFO - Reading from file tmpfile_stdout 08:47:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:44 INFO - Reading from file tmpfile_stdout 08:47:44 INFO - Output received: 08:47:44 INFO - Usage: mozinstall [options] installer 08:47:44 INFO - Options: 08:47:44 INFO - -h, --help show this help message and exit 08:47:44 INFO - -d DEST, --destination=DEST 08:47:44 INFO - Directory to install application into. [default: 08:47:44 INFO - "/builds/slave/test"] 08:47:44 INFO - --app=APP Application being installed. [default: firefox] 08:47:44 INFO - mkdir: /builds/slave/test/build/application 08:47:44 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:47:44 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:19 INFO - Reading from file tmpfile_stdout 08:48:19 INFO - Output received: 08:48:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:48:19 INFO - Running post-action listener: _resource_record_post_action 08:48:19 INFO - [mozharness: 2016-10-29 15:48:19.749521Z] Finished install step (success) 08:48:19 INFO - [mozharness: 2016-10-29 15:48:19.749654Z] Running run-tests step. 08:48:19 INFO - Running pre-action listener: _resource_record_pre_action 08:48:19 INFO - Running main action method: run_tests 08:48:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:48:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:48:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:48:19 INFO - 2016-10-29 08:48:19.764 screenresolution[1916:9148] starting screenresolution argv=screenresolution get 08:48:19 INFO - 2016-10-29 08:48:19.766 screenresolution[1916:9148] Display 0: 1600x1200x32@60 08:48:19 INFO - 2016-10-29 08:48:19.772 screenresolution[1917:9150] starting screenresolution argv=screenresolution list 08:48:19 INFO - Available Modes on Display 0 08:48:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:48:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:48:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:48:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:48:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:48:20 INFO - Intel Iris: 08:48:20 INFO - Chipset Model: Intel Iris 08:48:20 INFO - Type: GPU 08:48:20 INFO - Bus: Built-In 08:48:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:48:20 INFO - Vendor: Intel (0x8086) 08:48:20 INFO - Device ID: 0x0a2e 08:48:20 INFO - Revision ID: 0x0009 08:48:20 INFO - Displays: 08:48:20 INFO - Display: 08:48:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:48:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:48:20 INFO - Display Serial Number: 1600x1200 60 08:48:20 INFO - Main Display: Yes 08:48:20 INFO - Mirror: Off 08:48:20 INFO - Online: Yes 08:48:20 INFO - Rotation: Supported 08:48:20 INFO - Return code: 0 08:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:20 INFO - Python 2.7.3 08:48:20 INFO - Return code: 0 08:48:20 INFO - grabbing minidump binary from tooltool 08:48:20 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:20 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 0x1046b4d30>, '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 0x1044dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046acb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:20 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:20 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:20 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:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:20 INFO - Return code: 0 08:48:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:48:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:48:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:20 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/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0236', '--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:20 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/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0236 --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:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.798QYNhcMw/Render', 08:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:20 INFO - 'HOME': '/Users/cltbld', 08:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:20 INFO - 'LOGNAME': 'cltbld', 08:48:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:20 INFO - 'MOZ_NO_REMOTE': '1', 08:48:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:20 INFO - 'NO_EM_RESTART': '1', 08:48:20 INFO - 'PAGER': '/bin/cat', 08:48:20 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:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:20 INFO - 'PWD': '/builds/slave/test', 08:48:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:20 INFO - 'SHELL': '/bin/bash', 08:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8c5UNMmsA5/Listeners', 08:48:20 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:20 INFO - 'USER': 'cltbld', 08:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:20 INFO - 'XPC_FLAGS': '0x0', 08:48:20 INFO - 'XPC_SERVICE_NAME': '0', 08:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:20 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/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0236', '--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:20 INFO - mozversion application_buildid: 20161029062222 08:48:20 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 08:48:20 INFO - mozversion application_display_name: Nightly 08:48:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:20 INFO - mozversion application_name: Firefox 08:48:20 INFO - mozversion application_remotingname: firefox 08:48:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:48:20 INFO - mozversion application_vendor: Mozilla 08:48:20 INFO - mozversion application_version: 52.0a1 08:48:20 INFO - mozversion platform_buildid: 20161029062222 08:48:20 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 08:48:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:48:20 INFO - mozversion platform_version: 52.0a1 08:48:20 INFO - using testdate: 1477756100 08:48:20 INFO - actual date: 1477756100 08:48:20 INFO - starting webserver on 'localhost:49442' 08:48:20 INFO - SUITE-START | Running 2 tests 08:48:20 INFO - TEST-START | dromaeo_css 08:48:20 INFO - operating with platform_type : mac_ 08:48:20 INFO - Initialising browser for dromaeo_css test... 08:48:20 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpm9Ev8X/profile http://localhost:49442/getInfo.html) 08:48:22 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 08:48:22 INFO - PROCESS | 1927 | colorDepth:24 08:48:22 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 08:48:22 INFO - PROCESS | 1927 | __metrics 08:48:22 INFO - PROCESS | 1927 | 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:22 INFO - PROCESS | 1927 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:23 INFO - TEST-INFO | 1927: exit 0 08:48:23 INFO - Browser initialized. 08:48:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:48:23 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpm9Ev8X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:35 INFO - PROCESS | 1929 | RSS: Main: 233615360 08:48:35 INFO - PROCESS | 1929 | 08:49:26 INFO - PROCESS | 1929 | 1477756166484 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:51:40 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49442/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49442/tests/dromaeo/cssquery-ext.html) 08:51:42 INFO - PROCESS | 1929 | RSS: Main: 382926848 08:51:42 INFO - PROCESS | 1929 | 08:54:45 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49442/tests/dromaeo/cssquery-ext.html (next: http://localhost:49442/tests/dromaeo/cssquery-jquery.html) 08:54:45 INFO - PROCESS | 1929 | RSS: Main: 375607296 08:54:45 INFO - PROCESS | 1929 | 08:57:48 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49442/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49442/tests/dromaeo/cssquery-mootools.html) 08:57:48 INFO - PROCESS | 1929 | RSS: Main: 334749696 08:57:48 INFO - PROCESS | 1929 | 09:00:51 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49442/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49442/tests/dromaeo/cssquery-prototype.html) 09:00:51 INFO - PROCESS | 1929 | RSS: Main: 340549632 09:00:51 INFO - PROCESS | 1929 | 09:03:54 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49442/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49442/tests/dromaeo/cssquery-yui.html) 09:03:55 INFO - PROCESS | 1929 | RSS: Main: 329269248 09:03:55 INFO - PROCESS | 1929 | 09:06:58 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:49442/tests/dromaeo/cssquery-yui.html (next: http://localhost:49442/tests/dromaeo/cssquery-dojo.html) 09:06:59 INFO - PROCESS | 1929 | RSS: Main: 368427008 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | __start_tp_report 09:06:59 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 09:06:59 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 09:06:59 INFO - PROCESS | 1929 | |i|pagename|runs| 09:06:59 INFO - PROCESS | 1929 | |0;dojo.html;3244.578204833372;3265.3306072255177;3292.3086151908096;3307.3881331953585;3308.718758905493;5481.150421684635;5535.474129957658;5552.611317207797;5660.886782264352;5690.374058853523;5584.357798853133;5619.4942455179025;5625.5218306444;5629.099344104944;5631.493165615094;5078.720670363138;5120.487951204868;5127.487251274862;5149.716765577892;5171.940027078744;5146.716930568818;5151.896962060757;5215.556677682402;5240.475952404767;5255.237990491377;5221.269022336875;5221.817236396727;5222.164453687411;5241.737913104349;5269.288646032794;5217.321748172732;5237.423883372826;5240.633155679085;5241.606879484054;5298.36419629643;4895.167821470359;4967.90064198714;5127.435982041972;5135.64050516464;5145.716985565792;5585.916211256835;5587.469190426944;5609.775608975636;5643.266375371217;5693.089105743061;6075.574709770318;6152.815415537541;6155.87688246237;6162.630242185483;6166.414190651881;5851.882962340772;5980.893534696052;6169.3522180170885;6230.408111229426;6237.906431403532;5546.306711661043;5618.719064046782;5624.55003599711;5677.063284558084;5679.517241034476;6115.392460734087;6172.69136543171;6189.938100619026;6239.500839932794;6239.812805615838;5036.269740887551;6019.465036415686;6046.697665116814;6055.091736239511;6070.605410648382;6035.456808887221;6173.59871608344;6183.938160618426;6198.2252218472695;6202.596831205957;6030.9747342951805;6037.215162028996;6104.277264894496;6106.572539922252;6115.877682446326;6128.294094580049;6148.1085242639565;6167.229096362955;6168.660723660242;6173.351798061229;4802.207635740064;4883.8290659826735;4900.068986892479;4914.557689807934;4940.258961155855;4325.502567204749;4396.120775844844;4411.250087485135;4442.466903971479;4445.666575006888;5622.493975542221;5643.746031428595;5650.4349565043985;5664.603477756517;5673.461021202979;6158.322584515699;6165.907511387333;6170.444659980533;6178.41305076017;6184.350643182491;5609.579281553818;5642.492175704124;5648.63283886546;5650.830475085754;5661.858453538694;4582.495925448198;5316.548093412026;5341.786328546815;5349.1976203569;5358.196270559447;5292.735363231746;6197.25632924052;6221.751129954751;6222.253329600477;6234.0337247725765;6158.107074474086;6207.441330280297;6227.06594010902;6232;6236.6258024518675;6287.46556542699;6294.3076261612105;6307.873842523032;6320.968395157995;6323.810285691253;5954.970225148846;6012.6392416455155;6016.458518733335;6040.365761595145;6109.08363745424;6089.761056641996;6148.600340977822;6201.751929922933;6212.751489940351;6231;5970.582059255984;6003.159557661844;6009.45914867664;6017.638941663514;6080.847978800389;4861.805527778991;5861;5911.793087241926;5984.222051133324;6003.189569408074;5821.94178058214;5837;5853.239078919713;5910.940890591039;5925.733341999534;5014.84955451337;6052.243469566304;6064.878702425838;6066.181065556093;6069.998450255658;5843.474087332161;5868.735906884286;5869.853253668693;5870.442307980735;5883.705814709162 09:06:59 INFO - PROCESS | 1929 | |1;ext.html;461.43935118830615;473.11527443680325;498.9372636284713;523.5837509180204;535.4404647143739;31131.844340778294;41220.79389603052;42649.72050838472;42725.35911961319;44414.77792611033;43820.34269485952;44262.557374426244;44405;44421.33367999482;44432;9411.905880941189;9588.472634005127;9588.712338629817;9596.952015239915;9603.32776705631;9441.480718560477;9541.188998935064;9542.52287385628;9546.379485333466;9577;9527.475988820612;9587.13715765581;9588.760280992961;9594.856077158849;9625.71122866315;9501.287403444734;9528.190103841182;9569.473678947621;9577.185939195177;9585.089416505421;9371.76570585734;9440.952795236048;9446.622135114587;9455.054494550559;9455.52722363879;40844.774656760346;41235.96910077242;41293.793531032155;41304.38043429351;41450.79274603607;3174.9206269843207;3190.840457977115;3298.818564978925;3518.4546395308766;3531.5055892175114;23777.88111059451;31130;31747.52378714321;31821.363572728416;32265.35469290601;3223.597050368704;3280.721138703213;3323.5845519310087;3330.733541316689;3359.5128706337687;471209.1295806614;477021;477352;477835.43810180854;479237.6038119787;27693;62513.37486625167;63008;63165.68417157885;63207;34078.829605852305;34293.82853085719;34357.48463773046;34440.31119377598;34543.4818477723;13666.385012674453;13749.931250343885;13761.518346857813;13768.449262029608;13771.380287887068;11771.293722376684;11802;11811.940940295415;11819.763604728028;11824.11319151067;7603.695852165852;7660.2722741339485;7681.3854891608535;7690.923090769133;7731.7680469586;3147.27612649092;3185.4584720597554;3185.840707964639;3186.9043928682177;3229.838508074587;833.2584000239791;835.7994081420537;935.4948327902993;937.406409104525;998.3610489286863;28449.85775071153;29455.410891782045;29608.55587166194;30281.848590757345;30284.394312113633;783.8510682970217;988.4563490080427;1032.6901929421144;1130.0846314485293;1136.0116698472216;14969.925150374178;15547;15595.922020390053;15620;16025.519234422985;624572;630337.9043829116;630531;631193;632390;51710;57489.712551436976;58002.709986449794;58132.4186758127;58188.70905645445;1214.8967337776387;1226.6013545597716;1355.945762169522;1371.2252577293798;1396.190209678384;29969.850150749106;30445.086647400614;31368.686313136575;31588.684113158575;32121.839390802896;52380.21429678482;53000.93998120093;53019.46980530145;53092.67268318323;53096.67258318573;508533;510067;511819;511879.4406028095;732639.3784403997;42991.57008429876;43310.56689433065;43485.782571086944;44068.33897491604;44140.33789493224;47437.76281118573;48524.27213591729;49299;49497;49540.50459495359;35021.82489087538;39866.81731374903;40304;40770.776876693744;40797.79601101975;39622.80188599038;40655.1868962625;40729.38905916354;40795;42003.73988780219;31446;38671;38846.80576597099;38888.80555597204;39528.40707389334;33944.53266221258;34865;35178.64821351754;35707;35729.64270357263;21472.67790983105;23351.299461016195;24341.756582434657;24854.130105446224;26189.869050654626 09:06:59 INFO - PROCESS | 1929 | |2;jquery.html;329.5304191527075;346.8092549097996;350.0443788457512;378.17180374978784;386.5850985393459;12683.809742853864;14269.429222831088;15204.543863684079;15449.845501544982;20720.585588288224;19665.213391464324;19951.40145795625;20605.484862878435;20702;20711.585768284625;5667.744951477193;6025.939740602582;6031.185789918371;6044.425779550936;6050.183225264599;4925.7783399747095;5849.678267695275;5884.6763428011445;5936.940630593682;5962.373950735176;5885.911711324334;5886.381929897363;5892.734826932799;5901.114832775075;5912.260967379078;4956.835143741236;5334.146536554152;5863.413658634145;5870.295564532241;5878.294604647427;4461.263891457906;4779.617630589544;5001.895791343212;5071.366079240095;5153.845384638467;24547;25034.624480632807;25061.62407563888;25636.35909102269;25958.87020564904;2322.744498105224;2417.2748175547267;2554.246497283287;2624.107803346871;2911.796174267802;14930.47743328989;15216.771748423782;15424.5372638821;16165.595860103474;16233.944793588496;1806.4851517317634;1850.8796928199624;1868.7010078387393;1902.4863286912457;1907.895065771382;114255;115279.42360288229;115595.42202289018;116150.41924790406;117978;10386.584536618451;10410.947945260225;10417.30185784051;10547.525361358757;10769.9461502692;13312.800307995389;13375.398107085204;13405;13410.597682069554;13418.731625367438;6657;6955.756548520778;8337.249647531751;8523.65905363791;8685.826283474295;8523.701670441505;8544.957275213708;8580.742577722678;8666.789968557978;8699.391042627081;6418.454431373386;6547.410733034049;6561.967190164019;6578.736850526021;6590.8352291193105;1544.783730277762;1784.6073863750214;1815.1287382056687;1828.2138680367304;1853.7765075050402;711.7224282529818;809.8015986083448;963.21016766251;1022.5909636145452;1024.4877561219391;20659.380218593466;22265.777342226695;22350;22409.775902241094;22519;845.940784145104;946.1673727120228;1011.9139873110721;1017.4200705597739;1054.1619412567027;11306.038986686059;11667.941660291644;11695.707607309716;11825.408729563487;11877.88122118785;546829;553749;560397;561017;562518;62730.118096457176;80959;83279.58360208281;94491.22035118518;104318.47840760747;940.6425558287943;958.3243813111878;993.2401712689798;994.3536701144169;995.2833959549258;19224;19721;20027.792773878606;20036.799632003494;20083.698744519137;30323.69676303297;35567.822160890064;45553;46153;46158.76920615375;65798.67100664465;65911.85159635919;66050.03699778029;66326;67508.3249167502;7567.962160189164;7729.1884352142215;7804.141544429995;7813.492123011986;8006.639701213576;12356.320402377596;12397.504099835905;12511.56209532662;12763.80854287205;12889.419976101286;10649.307794993301;10833.783324333312;10915.945420272848;11149.55401783952;11205.271657342246;10559.155267578422;10686.198535110054;10696.41169735672;10711.785764284516;10994.725131871768;11002;11273.492692829006;11353.943230283796;11445.599404020819;11529.942350288195;6884.277150899084;7612.276833700789;7899.486533375312;7940.6029698513685;8012.158723334199;9186.173244407768;10829.24195306321;10984;10985.725356866142;11002.50488728025 09:06:59 INFO - PROCESS | 1929 | |3;mootools.html;1525.4203402706974;1559.8518140776628;1778.1820362633189;1911.1781933768475;1939.3503176435884;8142.796430089251;8578.541647919845;8584.570771461433;8592.097829727882;8597.871031934526;7555.622218889047;7777.805554861131;8119.3910456715685;8360.414770966036;8397.748067557983;2294.575503531848;2328.790408863202;2329.778671026258;2333.7899589036983;2335.0309621507054;2295.2196253273883;2305.3660243433023;2316.6756654068445;2346.9765302347014;2355.7879790818824;1947.4936516505668;2149.8710077395326;2286.7141607299086;2302.470431800687;2309.203324852923;2276.886155692217;2297.5979203639463;2299.91950281741;2299.9310020699404;2302.113686230805;2281.908723651052;2288.119074156445;2322.581935251654;2337;2340.789328960385;8481.406301558893;8543.444676096096;8551.615177316973;8557.058723540405;8569.871451928226;5120.462351453119;5272.340957380327;5273.973630131824;5279.973600132013;5282.788688452457;3376.2234686022352;3410.2497450560836;3610.5016418186683;3686.3733165361955;3688.160116710145;1049.9370037797758;1065.1744897704264;1070.7430216748003;1087.3856271206744;1094.03178187304;8617.48295102296;10987.230893837355;11089.889101108967;11146.21976461648;11175.552977880876;4457.197704413172;4583.427071616048;4673.042026384583;4683.250679891201;4719.693219940762;9505.477198754135;9531.38046027006;9538.856917146248;9539.570719317648;9544.856827147598;5249.763760630781;5253.343332083489;5254.448282930237;5270.604704647167;5272.630915835932;3999.2601368746873;4203.4115223868685;4792.0895029944195;4826.396700412449;4829.806807727722;3729.776213427203;3763.6989040876665;3812.885613431546;3837.6162383761402;3855.2867719471988;1240.3178251961385;1251.8372611560621;1253.3044160491015;1262.2868079535033;1263;910.2763303173992;914.7484441778564;924.089771574998;934.528063328015;967.7338731848657;5147.613928955343;5604.775808967595;5639;5861.238039054895;5987.760489580455;440.26475785438396;932.137772560379;1007.1690855044618;1036.9481525923673;1059.7403636109048;3685.2261025184475;3707.647773461517;3810.5998870118237;3980.4029395590314;3980.681545476355;9760;10102.494875256209;10257.17942564593;10266.691999239885;10289.9485502572;9836.409815411098;10087.344322619007;10286.485675716185;10292;10297.691069267934;5929.288485381696;7601.12587052485;7906.604669766489;8076.192380761877;8096.8380632387025;5215.29593504872;5513.614047016831;5672.404397538364;5705.572082093777;5817.272840894888;9344.859827102735;9361.098059601545;9383.202427793714;9421.528923553658;9442.38624489406;9107.817843643223;9617.951910240405;9635.325527213028;9700;9705.951470242604;6311.715972781328;6504.934950650622;6507.251666058274;6733.3939945405145;6900.3444672756;7428.294312040348;7567.205443428581;7664.501807382502;7669.7315593953945;7996.800079998046;6657.7669781557415;6833.316668333326;6857.27998560144;6956.5478243913985;6958.06066181059;6229.96885015572;7158.498905076594;7180.892286615601;7201.71193152268;7257.927420725725;6554.437692997349;6665.700043497957;6762.52662313653;6764.729410823512;6772.525923185527;4850.417949846041;4882.4629290777275;4890.682105663121;4931.827386041615;5027.296178534935;4841.322214889848;4888;4931.112399767932;5011.574016208663;5105.285260063668 09:06:59 INFO - PROCESS | 1929 | |4;prototype.html;263.59932901988975;275;302.1268533936923;310.1470954874096;318.6717680788788;4401.867943961683;4686.90626187476;4758.333833263346;4791.137595232856;5263.236830659557;4269.231538323101;4994.8501544953615;5091.770870310836;5153.407358153813;5192;3468.3410152071024;3816.5992570780086;3999.320115580358;4023.5171779386515;4028.7381320214167;3624.7313440295816;3767.9058023549355;3807.3527500325013;4007.4971885542923;4034.7175697701173;3223.9194020149566;3661.212839239563;3732.6267373262594;3959.366501359783;3988.940165897514;3941.6649584785328;3943.842246310144;3971.6028397160344;3975.8807235782974;4020.336644453662;2715.8370497770197;3416.6241713411755;3452.413089774719;3455.395305821471;3480.773749706261;4478.208716513421;4890.926636100461;5050.444451110375;5159.948400515985;5176.663516871391;4291;4441.200583894898;4463.152001119809;4520.412346394947;4534.344964088117;5307.575393968474;5457.645253058578;5508.3114610673665;5521.779128834842;5527.668339899619;3217.533457648651;3635.872879407366;3769.491118698968;3770.736803170941;3780.092777733352;5073.441921388644;5149.253358263031;5649.576281778883;5796.681182534959;5823.040332573848;3725.6460636239512;3750.5311836020496;3765.246950609889;3789.317922773927;3792.27946690128;3044.6346438427086;3633.400488919299;3775.244951009809;3871.9806400967814;3875.7403843750894;3682.116292089879;3743.5694895086867;4434.246178149722;4502.684812063124;4544.750503390092;5566.972165139148;5578.3543854563;5578.748956296977;5578.86052848682;5584.301962254718;1120.5013768872936;1248.9750204995848;1249.3940438887132;1280.1949251555263;1294.5080869269805;651.2900937977532;762.954222746637;782.9686812527549;810.3922058456158;828.2090603473669;4035.6367926886132;4165.771097526237;4245.172191422643;4264.701470897069;4283.785810709452;4700.741459219776;4721.881952951204;4765.760092756399;4776.259679749644;4866.562009419169;3837.972256344198;3988.3419235825763;4011.3180759270995;4127.885470922834;4220.831166753357;2085.9165633374496;2208.4492411265014;2308.6421604651305;2325.6976593042796;2410.963835542468;4358.063016451478;4436.578525040116;4694.694844835075;4802.919343147833;4830.227163653869;3924.4898163238595;4029.7582145071387;4559.635229181657;4717.693349932243;4746.742113339968;4109.486314210723;4262.7016108872085;4792.993471370912;4847.491013443609;4849.539293767016;4402.581754733424;4403.383526306384;4719.702081927498;4738.573528382462;4806.879828004188;4181.51912530063;4420.756858372821;4595.586397224266;4666.743329116795;4671.27595222741;4292.828286868616;4361.681934884505;4763.356946812275;4818.734969576707;4868.245421959602;2843.701411351861;3016.743576795909;3247.944418064186;3249.2201871550183;3278.377298161414;4411.3824064630335;4453.888652783707;4623.42207224097;4698.671093023456;4699.03669747694;5014.7994080236385;5462.426445223195;5530.281063461724;5545.2513910623165;5589;4703.635945575745;5554.611177217556;5574.275344205227;5599.264228089305;5616.865591075365;4040.717149799486;4957.603391728725;5233.7383130842545;5483.7806487740045;5542.224088627515;4782;5088.974555127201;5165.66423182492;5323.1216849219445;5608.46719561641;4861.51384861511;4902.862168212276;5236.842894713165;5477.3427188737605;5487.972560137174 09:06:59 INFO - PROCESS | 1929 | |5;yui.html;713.4684659928353;715.4991505945836;746.5110352718964;779.3998621061783;827.648249493965;12702.428390722416;13535.932320338408;14069.944754143442;15142.924285378558;15209.23953802311;11161.553537858475;13773.311334433263;13803.447862085504;13818.79271810921;13823;681.9590824550518;701.8771714949889;705.6789160931789;836.8493671139223;839.6137776622761;845.5180547088162;853.4537895746727;859.8495263328924;859.9183077607618;861.3023451004706;917.7246825952221;918.0544039639183;918.2103391083696;920.4017388697333;921.4102974096584;706.7914965085312;732.2896790113581;909.3634455880909;911.6535716427782;912.5482885971453;649.3765984654738;668.0880597983718;671.3018460800762;671.5668393885916;672.1195234243108;14605.269736513132;14688.926555367154;14697.632559185999;14713;14720.558383248519;13256.53602123921;13373.131964141643;13390.799138012937;13454.529091481849;13563.796543051763;11986.340751258676;12107.93946030273;12114.273143611412;12325.93837030818;12696.80954785679;4407.779611019436;4499.775011249457;4529.411176547061;4541.45502539694;4597.7011494252765;80103.69538982685;83507;83704.74442883361;83905.58047209786;83935;10374.429406382722;10549.89450105489;10589.84115238272;10615.469226538797;10696.197785166143;20799.8960005199;20802.167913283298;20807;20815.687764683542;20844.687329690067;7441.255874412515;7621.31408173267;7794.610269486503;7801.609919504002;7811;4089.0595163112653;4135.8966025849595;4137.089840235143;4183.958160418418;4381.605655491021;3371.5279860819505;3470.8611655534;3494.266204097117;3495.528103706018;3498;625.5683578330937;634;641.2529403245167;645.9773907913294;656.1109696361457;489.0732062741086;500.39202369121693;558.154396089924;604.1602172979561;607.4745345276392;8444.704435344733;8642.567871606394;8862.601182946783;8942.68700595476;9182.716404726356;620.500497099839;626.5269721360344;631.6399652198295;647.3882181338683;649.357136434926;3763.303788799081;4244.896326955014;4358.237308471005;4395.472543294825;4400.317950717644;93039.5348023269;108992;110932.89067109388;114504;116741.41629291799;76421.61789191018;83910.58044709737;101944;102578.48710756398;105035;87988.56005720058;88008.5599571998;88513;90043.09956900348;92436.53781731048;8267.83464330722;8494.617742201492;8540.615672294638;8815.382923195571;8862.645494180419;57048;57341;57938;58027;58826.11760823506;76823;79951;81924;82224.58887705523;82717;9307.953460232655;11074.169437292074;11118.221724479532;11337.886621133683;11844.46699898524;9956.402615843073;10445.059944605022;11811.763764724828;11997.520099195934;12063.21589096706;11339.659810205707;11585.131115166228;11686.18196726221;11711.824322635337;11845.940770296093;11528.769424611293;11587.536498540301;11642.24325418845;11661.591844285409;12112.939435302767;11313.434328283389;11359.886401135884;11404.657860264206;11518.020968217796;11551;7966.84066318682;8067.798305042421;9602.991685872883;9892.208623310262;9892.703218903445;8012.879806803019;8396.32829373661;9154.816903661756;9310.0224476429;9749.756256093655 09:06:59 INFO - PROCESS | 1929 | __end_tp_report 09:06:59 INFO - PROCESS | 1929 | __start_cc_report 09:06:59 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,1465 09:06:59 INFO - PROCESS | 1929 | __end_cc_report 09:06:59 INFO - PROCESS | 1929 | __startTimestamp1477757219136__endTimestamp 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | ------- Summary: start ------- 09:06:59 INFO - PROCESS | 1929 | Number of tests: 6 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5645.78 Median:5851.88 stddev:636.18 (10.9%) stddev-sans-first:609.61 09:06:59 INFO - PROCESS | 1929 | Values: 3244.6 3265.3 3292.3 3307.4 3308.7 5481.2 5535.5 5552.6 5660.9 5690.4 5584.4 5619.5 5625.5 5629.1 5631.5 5078.7 5120.5 5127.5 5149.7 5171.9 5146.7 5151.9 5215.6 5240.5 5255.2 5221.3 5221.8 5222.2 5241.7 5269.3 5217.3 5237.4 5240.6 5241.6 5298.4 4895.2 4967.9 5127.4 5135.6 5145.7 5585.9 5587.5 5609.8 5643.3 5693.1 6075.6 6152.8 6155.9 6162.6 6166.4 5851.9 5980.9 6169.4 6230.4 6237.9 5546.3 5618.7 5624.6 5677.1 5679.5 6115.4 6172.7 6189.9 6239.5 6239.8 5036.3 6019.5 6046.7 6055.1 6070.6 6035.5 6173.6 6183.9 6198.2 6202.6 6031.0 6037.2 6104.3 6106.6 6115.9 6128.3 6148.1 6167.2 6168.7 6173.4 4802.2 4883.8 4900.1 4914.6 4940.3 4325.5 4396.1 4411.3 4442.5 4445.7 5622.5 5643.7 5650.4 5664.6 5673.5 6158.3 6165.9 6170.4 6178.4 6184.4 5609.6 5642.5 5648.6 5650.8 5661.9 4582.5 5316.5 5341.8 5349.2 5358.2 5292.7 6197.3 6221.8 6222.3 6234.0 6158.1 6207.4 6227.1 6232.0 6236.6 6287.5 6294.3 6307.9 6321.0 6323.8 5955.0 6012.6 6016.5 6040.4 6109.1 6089.8 6148.6 6201.8 6212.8 6231.0 5970.6 6003.2 6009.5 6017.6 6080.8 4861.8 5861.0 5911.8 5984.2 6003.2 5821.9 5837.0 5853.2 5910.9 5925.7 5014.8 6052.2 6064.9 6066.2 6070.0 5843.5 5868.7 5869.9 5870.4 5883.7 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:68254.68 Median:42326.73 stddev:149710.94 (353.7%) stddev-sans-first:150044.39 09:06:59 INFO - PROCESS | 1929 | Values: 461.4 473.1 498.9 523.6 535.4 31131.8 41220.8 42649.7 42725.4 44414.8 43820.3 44262.6 44405.0 44421.3 44432.0 9411.9 9588.5 9588.7 9597.0 9603.3 9441.5 9541.2 9542.5 9546.4 9577.0 9527.5 9587.1 9588.8 9594.9 9625.7 9501.3 9528.2 9569.5 9577.2 9585.1 9371.8 9441.0 9446.6 9455.1 9455.5 40844.8 41236.0 41293.8 41304.4 41450.8 3174.9 3190.8 3298.8 3518.5 3531.5 23777.9 31130.0 31747.5 31821.4 32265.4 3223.6 3280.7 3323.6 3330.7 3359.5 471209.1 477021.0 477352.0 477835.4 479237.6 27693.0 62513.4 63008.0 63165.7 63207.0 34078.8 34293.8 34357.5 34440.3 34543.5 13666.4 13749.9 13761.5 13768.4 13771.4 11771.3 11802.0 11811.9 11819.8 11824.1 7603.7 7660.3 7681.4 7690.9 7731.8 3147.3 3185.5 3185.8 3186.9 3229.8 833.3 835.8 935.5 937.4 998.4 28449.9 29455.4 29608.6 30281.8 30284.4 783.9 988.5 1032.7 1130.1 1136.0 14969.9 15547.0 15595.9 15620.0 16025.5 624572.0 630337.9 630531.0 631193.0 632390.0 51710.0 57489.7 58002.7 58132.4 58188.7 1214.9 1226.6 1355.9 1371.2 1396.2 29969.9 30445.1 31368.7 31588.7 32121.8 52380.2 53000.9 53019.5 53092.7 53096.7 508533.0 510067.0 511819.0 511879.4 732639.4 42991.6 43310.6 43485.8 44068.3 44140.3 47437.8 48524.3 49299.0 49497.0 49540.5 35021.8 39866.8 40304.0 40770.8 40797.8 39622.8 40655.2 40729.4 40795.0 42003.7 31446.0 38671.0 38846.8 38888.8 39528.4 33944.5 34865.0 35178.6 35707.0 35729.6 21472.7 23351.3 24341.8 24854.1 26189.9 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:31980.86 Median:14095.30 stddev:92193.50 (654.1%) stddev-sans-first:92421.49 09:06:59 INFO - PROCESS | 1929 | Values: 329.5 346.8 350.0 378.2 386.6 12683.8 14269.4 15204.5 15449.8 20720.6 19665.2 19951.4 20605.5 20702.0 20711.6 5667.7 6025.9 6031.2 6044.4 6050.2 4925.8 5849.7 5884.7 5936.9 5962.4 5885.9 5886.4 5892.7 5901.1 5912.3 4956.8 5334.1 5863.4 5870.3 5878.3 4461.3 4779.6 5001.9 5071.4 5153.8 24547.0 25034.6 25061.6 25636.4 25958.9 2322.7 2417.3 2554.2 2624.1 2911.8 14930.5 15216.8 15424.5 16165.6 16233.9 1806.5 1850.9 1868.7 1902.5 1907.9 114255.0 115279.4 115595.4 116150.4 117978.0 10386.6 10410.9 10417.3 10547.5 10769.9 13312.8 13375.4 13405.0 13410.6 13418.7 6657.0 6955.8 8337.2 8523.7 8685.8 8523.7 8545.0 8580.7 8666.8 8699.4 6418.5 6547.4 6562.0 6578.7 6590.8 1544.8 1784.6 1815.1 1828.2 1853.8 711.7 809.8 963.2 1022.6 1024.5 20659.4 22265.8 22350.0 22409.8 22519.0 845.9 946.2 1011.9 1017.4 1054.2 11306.0 11667.9 11695.7 11825.4 11877.9 546829.0 553749.0 560397.0 561017.0 562518.0 62730.1 80959.0 83279.6 94491.2 104318.5 940.6 958.3 993.2 994.4 995.3 19224.0 19721.0 20027.8 20036.8 20083.7 30323.7 35567.8 45553.0 46153.0 46158.8 65798.7 65911.9 66050.0 66326.0 67508.3 7568.0 7729.2 7804.1 7813.5 8006.6 12356.3 12397.5 12511.6 12763.8 12889.4 10649.3 10833.8 10915.9 11149.6 11205.3 10559.2 10686.2 10696.4 10711.8 10994.7 11002.0 11273.5 11353.9 11445.6 11529.9 6884.3 7612.3 7899.5 7940.6 8012.2 9186.2 10829.2 10984.0 10985.7 11002.5 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5447.28 Median:5112.87 stddev:2975.88 (58.2%) stddev-sans-first:2969.63 09:06:59 INFO - PROCESS | 1929 | Values: 1525.4 1559.9 1778.2 1911.2 1939.4 8142.8 8578.5 8584.6 8592.1 8597.9 7555.6 7777.8 8119.4 8360.4 8397.7 2294.6 2328.8 2329.8 2333.8 2335.0 2295.2 2305.4 2316.7 2347.0 2355.8 1947.5 2149.9 2286.7 2302.5 2309.2 2276.9 2297.6 2299.9 2299.9 2302.1 2281.9 2288.1 2322.6 2337.0 2340.8 8481.4 8543.4 8551.6 8557.1 8569.9 5120.5 5272.3 5274.0 5280.0 5282.8 3376.2 3410.2 3610.5 3686.4 3688.2 1049.9 1065.2 1070.7 1087.4 1094.0 8617.5 10987.2 11089.9 11146.2 11175.6 4457.2 4583.4 4673.0 4683.3 4719.7 9505.5 9531.4 9538.9 9539.6 9544.9 5249.8 5253.3 5254.4 5270.6 5272.6 3999.3 4203.4 4792.1 4826.4 4829.8 3729.8 3763.7 3812.9 3837.6 3855.3 1240.3 1251.8 1253.3 1262.3 1263.0 910.3 914.7 924.1 934.5 967.7 5147.6 5604.8 5639.0 5861.2 5987.8 440.3 932.1 1007.2 1036.9 1059.7 3685.2 3707.6 3810.6 3980.4 3980.7 9760.0 10102.5 10257.2 10266.7 10289.9 9836.4 10087.3 10286.5 10292.0 10297.7 5929.3 7601.1 7906.6 8076.2 8096.8 5215.3 5513.6 5672.4 5705.6 5817.3 9344.9 9361.1 9383.2 9421.5 9442.4 9107.8 9618.0 9635.3 9700.0 9706.0 6311.7 6504.9 6507.3 6733.4 6900.3 7428.3 7567.2 7664.5 7669.7 7996.8 6657.8 6833.3 6857.3 6956.5 6958.1 6230.0 7158.5 7180.9 7201.7 7257.9 6554.4 6665.7 6762.5 6764.7 6772.5 4850.4 4882.5 4890.7 4931.8 5027.3 4841.3 4888.0 4931.1 5011.6 5105.3 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:4124.26 Median:4447.54 stddev:1276.01 (28.7%) stddev-sans-first:1246.25 09:06:59 INFO - PROCESS | 1929 | Values: 263.6 275.0 302.1 310.1 318.7 4401.9 4686.9 4758.3 4791.1 5263.2 4269.2 4994.9 5091.8 5153.4 5192.0 3468.3 3816.6 3999.3 4023.5 4028.7 3624.7 3767.9 3807.4 4007.5 4034.7 3223.9 3661.2 3732.6 3959.4 3988.9 3941.7 3943.8 3971.6 3975.9 4020.3 2715.8 3416.6 3452.4 3455.4 3480.8 4478.2 4890.9 5050.4 5159.9 5176.7 4291.0 4441.2 4463.2 4520.4 4534.3 5307.6 5457.6 5508.3 5521.8 5527.7 3217.5 3635.9 3769.5 3770.7 3780.1 5073.4 5149.3 5649.6 5796.7 5823.0 3725.6 3750.5 3765.2 3789.3 3792.3 3044.6 3633.4 3775.2 3872.0 3875.7 3682.1 3743.6 4434.2 4502.7 4544.8 5567.0 5578.4 5578.7 5578.9 5584.3 1120.5 1249.0 1249.4 1280.2 1294.5 651.3 763.0 783.0 810.4 828.2 4035.6 4165.8 4245.2 4264.7 4283.8 4700.7 4721.9 4765.8 4776.3 4866.6 3838.0 3988.3 4011.3 4127.9 4220.8 2085.9 2208.4 2308.6 2325.7 2411.0 4358.1 4436.6 4694.7 4802.9 4830.2 3924.5 4029.8 4559.6 4717.7 4746.7 4109.5 4262.7 4793.0 4847.5 4849.5 4402.6 4403.4 4719.7 4738.6 4806.9 4181.5 4420.8 4595.6 4666.7 4671.3 4292.8 4361.7 4763.4 4818.7 4868.2 2843.7 3016.7 3247.9 3249.2 3278.4 4411.4 4453.9 4623.4 4698.7 4699.0 5014.8 5462.4 5530.3 5545.3 5589.0 4703.6 5554.6 5574.3 5599.3 5616.9 4040.7 4957.6 5233.7 5483.8 5542.2 4782.0 5089.0 5165.7 5323.1 5608.5 4861.5 4902.9 5236.8 5477.3 5488.0 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:20445.21 Median:57982.50 stddev:30433.75 (52.5%) stddev-sans-first:30483.06 09:06:59 INFO - PROCESS | 1929 | Values: 713.5 715.5 746.5 779.4 827.6 12702.4 13535.9 14069.9 15142.9 15209.2 11161.6 13773.3 13803.4 13818.8 13823.0 682.0 701.9 705.7 836.8 839.6 845.5 853.5 859.8 859.9 861.3 917.7 918.1 918.2 920.4 921.4 706.8 732.3 909.4 911.7 912.5 649.4 668.1 671.3 671.6 672.1 14605.3 14688.9 14697.6 14713.0 14720.6 13256.5 13373.1 13390.8 13454.5 13563.8 11986.3 12107.9 12114.3 12325.9 12696.8 4407.8 4499.8 4529.4 4541.5 4597.7 80103.7 83507.0 83704.7 83905.6 83935.0 10374.4 10549.9 10589.8 10615.5 10696.2 20799.9 20802.2 20807.0 20815.7 20844.7 7441.3 7621.3 7794.6 7801.6 7811.0 4089.1 4135.9 4137.1 4184.0 4381.6 3371.5 3470.9 3494.3 3495.5 3498.0 625.6 634.0 641.3 646.0 656.1 489.1 500.4 558.2 604.2 607.5 8444.7 8642.6 8862.6 8942.7 9182.7 620.5 626.5 631.6 647.4 649.4 3763.3 4244.9 4358.2 4395.5 4400.3 93039.5 108992.0 110932.9 114504.0 116741.4 76421.6 83910.6 101944.0 102578.5 105035.0 87988.6 88008.6 88513.0 90043.1 92436.5 8267.8 8494.6 8540.6 8815.4 8862.6 57048.0 57341.0 57938.0 58027.0 58826.1 76823.0 79951.0 81924.0 82224.6 82717.0 9308.0 11074.2 11118.2 11337.9 11844.5 9956.4 10445.1 11811.8 11997.5 12063.2 11339.7 11585.1 11686.2 11711.8 11845.9 11528.8 11587.5 11642.2 11661.6 12112.9 11313.4 11359.9 11404.7 11518.0 11551.0 7966.8 8067.8 9603.0 9892.2 9892.7 8012.9 8396.3 9154.8 9310.0 9749.8 09:06:59 INFO - PROCESS | 1929 | -------- Summary: end -------- 09:06:59 INFO - PROCESS | 1929 | 09:06:59 INFO - TEST-INFO | 1929: exit 0 09:06:59 INFO - TEST-OK | dromaeo_css | took 1119403ms 09:06:59 INFO - TEST-START | kraken 09:06:59 INFO - operating with platform_type : mac_ 09:06:59 INFO - Initialising browser for kraken test... 09:06:59 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpZ8TwQW/profile http://localhost:49442/getInfo.html) 09:07:02 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 09:07:02 INFO - PROCESS | 1934 | colorDepth:24 09:07:02 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 09:07:02 INFO - PROCESS | 1934 | __metrics 09:07:02 INFO - PROCESS | 1934 | 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:02 INFO - PROCESS | 1934 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:03 INFO - TEST-INFO | 1934: exit 0 09:07:03 INFO - Browser initialized. 09:07:03 INFO - Running cycle 1/1 for kraken test... 09:07:03 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpZ8TwQW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:14 INFO - PROCESS | 1935 | RSS: Main: 233115648 09:07:14 INFO - PROCESS | 1935 | 09:07:17 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49442/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:18 INFO - PROCESS | 1935 | RSS: Main: 293502976 09:07:18 INFO - PROCESS | 1935 | 09:07:21 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49442/tests/kraken/driver.html?testName=audio-dft) 09:07:21 INFO - PROCESS | 1935 | RSS: Main: 296345600 09:07:21 INFO - PROCESS | 1935 | 09:07:25 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49442/tests/kraken/driver.html?testName=audio-fft) 09:07:26 INFO - PROCESS | 1935 | RSS: Main: 386998272 09:07:26 INFO - PROCESS | 1935 | 09:07:28 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49442/tests/kraken/driver.html?testName=audio-oscillator) 09:07:28 INFO - PROCESS | 1935 | RSS: Main: 286801920 09:07:28 INFO - PROCESS | 1935 | 09:07:30 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49442/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:31 INFO - PROCESS | 1935 | RSS: Main: 290897920 09:07:31 INFO - PROCESS | 1935 | 09:07:34 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49442/tests/kraken/driver.html?testName=imaging-darkroom) 09:07:34 INFO - PROCESS | 1935 | RSS: Main: 329109504 09:07:34 INFO - PROCESS | 1935 | 09:07:37 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49442/tests/kraken/driver.html?testName=imaging-desaturate) 09:07:38 INFO - PROCESS | 1935 | RSS: Main: 330412032 09:07:38 INFO - PROCESS | 1935 | 09:07:40 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49442/tests/kraken/driver.html?testName=json-parse-financial) 09:07:41 INFO - PROCESS | 1935 | RSS: Main: 327868416 09:07:41 INFO - PROCESS | 1935 | 09:07:43 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49442/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:43 INFO - PROCESS | 1935 | RSS: Main: 303702016 09:07:43 INFO - PROCESS | 1935 | 09:07:45 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:46 INFO - PROCESS | 1935 | RSS: Main: 307077120 09:07:46 INFO - PROCESS | 1935 | 09:07:48 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:49 INFO - PROCESS | 1935 | RSS: Main: 317136896 09:07:49 INFO - PROCESS | 1935 | 09:07:52 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:52 INFO - PROCESS | 1935 | RSS: Main: 321220608 09:07:52 INFO - PROCESS | 1935 | 09:07:55 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:56 INFO - PROCESS | 1935 | RSS: Main: 321118208 09:07:56 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:49442/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49442/tests/kraken/driver.html?testName=ai-astar) 09:07:58 INFO - PROCESS | 1935 | RSS: Main: 364564480 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | __start_tp_report 09:07:58 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 09:07:58 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 09:07:58 INFO - PROCESS | 1935 | |i|pagename|runs| 09:07:58 INFO - PROCESS | 1935 | |0;ai-astar;111;113;113;114;114;114;121;166;162;114 09:07:58 INFO - PROCESS | 1935 | |1;audio-beat-detection;167;141;116;149;113;112;112;111;142;115 09:07:58 INFO - PROCESS | 1935 | |2;audio-dft;183;206;264;189;183;185;182;181;180;182 09:07:58 INFO - PROCESS | 1935 | |3;audio-fft;81;58;60;88;60;61;61;75;71;60 09:07:58 INFO - PROCESS | 1935 | |4;audio-oscillator;90;70;91;71;69;69;94;68;88;125 09:07:58 INFO - PROCESS | 1935 | |5;imaging-gaussian-blur;87;84;85;84;86;84;85;83;87;86 09:07:58 INFO - PROCESS | 1935 | |6;imaging-darkroom;92;94;94;93;92;94;94;94;93;92 09:07:58 INFO - PROCESS | 1935 | |7;imaging-desaturate;83;84;91;85;82;83;86;85;82;82 09:07:58 INFO - PROCESS | 1935 | |8;json-parse-financial;56;55;55;54;55;56;55;56;55;55 09:07:58 INFO - PROCESS | 1935 | |9;json-stringify-tinderbox;64;72;70;76;74;70;70;69;69;70 09:07:58 INFO - PROCESS | 1935 | |10;stanford-crypto-aes;90;91;91;87;88;90;88;93;99;100 09:07:58 INFO - PROCESS | 1935 | |11;stanford-crypto-ccm;143;149;149;153;158;146;146;147;177;146 09:07:58 INFO - PROCESS | 1935 | |12;stanford-crypto-pbkdf2;224;173;171;175;173;171;172;172;171;171 09:07:58 INFO - PROCESS | 1935 | |13;stanford-crypto-sha256-iterative;68;68;66;67;66;68;66;66;67;67 09:07:58 INFO - PROCESS | 1935 | __end_tp_report 09:07:58 INFO - PROCESS | 1935 | __start_cc_report 09:07:58 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,2003 09:07:58 INFO - PROCESS | 1935 | __end_cc_report 09:07:58 INFO - PROCESS | 1935 | __startTimestamp1477757278330__endTimestamp 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | ------- Summary: start ------- 09:07:58 INFO - PROCESS | 1935 | Number of tests: 14 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#0] ai-astar Cycles:10 Average:124.20 Median:114.00 stddev:21.15 (18.6%) stddev-sans-first:21.89 09:07:58 INFO - PROCESS | 1935 | Values: 111.0 113.0 113.0 114.0 114.0 114.0 121.0 166.0 162.0 114.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:128.50 stddev:20.18 (15.7%) stddev-sans-first:15.65 09:07:58 INFO - PROCESS | 1935 | Values: 167.0 141.0 116.0 149.0 113.0 112.0 112.0 111.0 142.0 115.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#2] audio-dft Cycles:10 Average:193.50 Median:184.00 stddev:25.91 (14.1%) stddev-sans-first:27.20 09:07:58 INFO - PROCESS | 1935 | Values: 183.0 206.0 264.0 189.0 183.0 185.0 182.0 181.0 180.0 182.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#3] audio-fft Cycles:10 Average:67.50 Median:66.00 stddev:10.62 (16.1%) stddev-sans-first:10.07 09:07:58 INFO - PROCESS | 1935 | Values: 81.0 58.0 60.0 88.0 60.0 61.0 61.0 75.0 71.0 60.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#4] audio-oscillator Cycles:10 Average:83.50 Median:79.50 stddev:18.11 (22.8%) stddev-sans-first:19.05 09:07:58 INFO - PROCESS | 1935 | Values: 90.0 70.0 91.0 71.0 69.0 69.0 94.0 68.0 88.0 125.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:85.50 stddev:1.37 (1.6%) stddev-sans-first:1.27 09:07:58 INFO - PROCESS | 1935 | Values: 87.0 84.0 85.0 84.0 86.0 84.0 85.0 83.0 87.0 86.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 09:07:58 INFO - PROCESS | 1935 | Values: 92.0 94.0 94.0 93.0 92.0 94.0 94.0 94.0 93.0 92.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:2.75 (3.3%) stddev-sans-first:2.88 09:07:58 INFO - PROCESS | 1935 | Values: 83.0 84.0 91.0 85.0 82.0 83.0 86.0 85.0 82.0 82.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 09:07:58 INFO - PROCESS | 1935 | Values: 56.0 55.0 55.0 54.0 55.0 56.0 55.0 56.0 55.0 55.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:3.20 (4.6%) stddev-sans-first:2.42 09:07:58 INFO - PROCESS | 1935 | Values: 64.0 72.0 70.0 76.0 74.0 70.0 70.0 69.0 69.0 70.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:90.50 stddev:4.47 (4.9%) stddev-sans-first:4.70 09:07:58 INFO - PROCESS | 1935 | Values: 90.0 91.0 91.0 87.0 88.0 90.0 88.0 93.0 99.0 100.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:149.00 stddev:9.95 (6.7%) stddev-sans-first:10.07 09:07:58 INFO - PROCESS | 1935 | Values: 143.0 149.0 149.0 153.0 158.0 146.0 146.0 147.0 177.0 146.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:172.50 stddev:16.46 (9.5%) stddev-sans-first:1.36 09:07:58 INFO - PROCESS | 1935 | Values: 224.0 173.0 171.0 175.0 173.0 171.0 172.0 172.0 171.0 171.0 09:07:58 INFO - PROCESS | 1935 | 09:07:58 INFO - PROCESS | 1935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 09:07:58 INFO - PROCESS | 1935 | Values: 68.0 68.0 66.0 67.0 66.0 68.0 66.0 66.0 67.0 67.0 09:07:58 INFO - PROCESS | 1935 | -------- Summary: end -------- 09:07:58 INFO - PROCESS | 1935 | 09:07:59 INFO - TEST-INFO | 1935: exit 0 09:07:59 INFO - TEST-OK | kraken | took 59458ms 09:07:59 INFO - SUITE-END | took 1178s 09:07:59 INFO - Completed test suite (00:19:39) 09:07:59 INFO - javascript benchmark 09:07:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3244.578204833372, 3265.3306072255177, 3292.3086151908096, 3307.3881331953585, 3308.718758905493, 5481.150421684635, 5535.474129957658, 5552.611317207797, 5660.886782264352, 5690.374058853523, 5584.357798853133, 5619.4942455179025, 5625.5218306444, 5629.099344104944, 5631.493165615094, 5078.720670363138, 5120.487951204868, 5127.487251274862, 5149.716765577892, 5171.940027078744, 5146.716930568818, 5151.896962060757, 5215.556677682402, 5240.475952404767, 5255.237990491377, 5221.269022336875, 5221.817236396727, 5222.164453687411, 5241.737913104349, 5269.288646032794, 5217.321748172732, 5237.423883372826, 5240.633155679085, 5241.606879484054, 5298.36419629643, 4895.167821470359, 4967.90064198714, 5127.435982041972, 5135.64050516464, 5145.716985565792, 5585.916211256835, 5587.469190426944, 5609.775608975636, 5643.266375371217, 5693.089105743061, 6075.574709770318, 6152.815415537541, 6155.87688246237, 6162.630242185483, 6166.414190651881, 5851.882962340772, 5980.893534696052, 6169.3522180170885, 6230.408111229426, 6237.906431403532, 5546.306711661043, 5618.719064046782, 5624.55003599711, 5677.063284558084, 5679.517241034476, 6115.392460734087, 6172.69136543171, 6189.938100619026, 6239.500839932794, 6239.812805615838, 5036.269740887551, 6019.465036415686, 6046.697665116814, 6055.091736239511, 6070.605410648382, 6035.456808887221, 6173.59871608344, 6183.938160618426, 6198.2252218472695, 6202.596831205957, 6030.9747342951805, 6037.215162028996, 6104.277264894496, 6106.572539922252, 6115.877682446326, 6128.294094580049, 6148.1085242639565, 6167.229096362955, 6168.660723660242, 6173.351798061229, 4802.207635740064, 4883.8290659826735, 4900.068986892479, 4914.557689807934, 4940.258961155855, 4325.502567204749, 4396.120775844844, 4411.250087485135, 4442.466903971479, 4445.666575006888, 5622.493975542221, 5643.746031428595, 5650.4349565043985, 5664.603477756517, 5673.461021202979, 6158.322584515699, 6165.907511387333, 6170.444659980533, 6178.41305076017, 6184.350643182491, 5609.579281553818, 5642.492175704124, 5648.63283886546, 5650.830475085754, 5661.858453538694, 4582.495925448198, 5316.548093412026, 5341.786328546815, 5349.1976203569, 5358.196270559447, 5292.735363231746, 6197.25632924052, 6221.751129954751, 6222.253329600477, 6234.0337247725765, 6158.107074474086, 6207.441330280297, 6227.06594010902, 6232.0, 6236.6258024518675, 6287.46556542699, 6294.3076261612105, 6307.873842523032, 6320.968395157995, 6323.810285691253, 5954.970225148846, 6012.6392416455155, 6016.458518733335, 6040.365761595145, 6109.08363745424, 6089.761056641996, 6148.600340977822, 6201.751929922933, 6212.751489940351, 6231.0, 5970.582059255984, 6003.159557661844, 6009.45914867664, 6017.638941663514, 6080.847978800389, 4861.805527778991, 5861.0, 5911.793087241926, 5984.222051133324, 6003.189569408074, 5821.94178058214, 5837.0, 5853.239078919713, 5910.940890591039, 5925.733341999534, 5014.84955451337, 6052.243469566304, 6064.878702425838, 6066.181065556093, 6069.998450255658, 5843.474087332161, 5868.735906884286, 5869.853253668693, 5870.442307980735, 5883.705814709162], "value": 5605.76408916732, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.43935118830615, 473.11527443680325, 498.9372636284713, 523.5837509180204, 535.4404647143739, 31131.844340778294, 41220.79389603052, 42649.72050838472, 42725.35911961319, 44414.77792611033, 43820.34269485952, 44262.557374426244, 44405.0, 44421.33367999482, 44432.0, 9411.905880941189, 9588.472634005127, 9588.712338629817, 9596.952015239915, 9603.32776705631, 9441.480718560477, 9541.188998935064, 9542.52287385628, 9546.379485333466, 9577.0, 9527.475988820612, 9587.13715765581, 9588.760280992961, 9594.856077158849, 9625.71122866315, 9501.287403444734, 9528.190103841182, 9569.473678947621, 9577.185939195177, 9585.089416505421, 9371.76570585734, 9440.952795236048, 9446.622135114587, 9455.054494550559, 9455.52722363879, 40844.774656760346, 41235.96910077242, 41293.793531032155, 41304.38043429351, 41450.79274603607, 3174.9206269843207, 3190.840457977115, 3298.818564978925, 3518.4546395308766, 3531.5055892175114, 23777.88111059451, 31130.0, 31747.52378714321, 31821.363572728416, 32265.35469290601, 3223.597050368704, 3280.721138703213, 3323.5845519310087, 3330.733541316689, 3359.5128706337687, 471209.1295806614, 477021.0, 477352.0, 477835.43810180854, 479237.6038119787, 27693.0, 62513.37486625167, 63008.0, 63165.68417157885, 63207.0, 34078.829605852305, 34293.82853085719, 34357.48463773046, 34440.31119377598, 34543.4818477723, 13666.385012674453, 13749.931250343885, 13761.518346857813, 13768.449262029608, 13771.380287887068, 11771.293722376684, 11802.0, 11811.940940295415, 11819.763604728028, 11824.11319151067, 7603.695852165852, 7660.2722741339485, 7681.3854891608535, 7690.923090769133, 7731.7680469586, 3147.27612649092, 3185.4584720597554, 3185.840707964639, 3186.9043928682177, 3229.838508074587, 833.2584000239791, 835.7994081420537, 935.4948327902993, 937.406409104525, 998.3610489286863, 28449.85775071153, 29455.410891782045, 29608.55587166194, 30281.848590757345, 30284.394312113633, 783.8510682970217, 988.4563490080427, 1032.6901929421144, 1130.0846314485293, 1136.0116698472216, 14969.925150374178, 15547.0, 15595.922020390053, 15620.0, 16025.519234422985, 624572.0, 630337.9043829116, 630531.0, 631193.0, 632390.0, 51710.0, 57489.712551436976, 58002.709986449794, 58132.4186758127, 58188.70905645445, 1214.8967337776387, 1226.6013545597716, 1355.945762169522, 1371.2252577293798, 1396.190209678384, 29969.850150749106, 30445.086647400614, 31368.686313136575, 31588.684113158575, 32121.839390802896, 52380.21429678482, 53000.93998120093, 53019.46980530145, 53092.67268318323, 53096.67258318573, 508533.0, 510067.0, 511819.0, 511879.4406028095, 732639.3784403997, 42991.57008429876, 43310.56689433065, 43485.782571086944, 44068.33897491604, 44140.33789493224, 47437.76281118573, 48524.27213591729, 49299.0, 49497.0, 49540.50459495359, 35021.82489087538, 39866.81731374903, 40304.0, 40770.776876693744, 40797.79601101975, 39622.80188599038, 40655.1868962625, 40729.38905916354, 40795.0, 42003.73988780219, 31446.0, 38671.0, 38846.80576597099, 38888.80555597204, 39528.40707389334, 33944.53266221258, 34865.0, 35178.64821351754, 35707.0, 35729.64270357263, 21472.67790983105, 23351.299461016195, 24341.756582434657, 24854.130105446224, 26189.869050654626], "value": 18763.004755783913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.5304191527075, 346.8092549097996, 350.0443788457512, 378.17180374978784, 386.5850985393459, 12683.809742853864, 14269.429222831088, 15204.543863684079, 15449.845501544982, 20720.585588288224, 19665.213391464324, 19951.40145795625, 20605.484862878435, 20702.0, 20711.585768284625, 5667.744951477193, 6025.939740602582, 6031.185789918371, 6044.425779550936, 6050.183225264599, 4925.7783399747095, 5849.678267695275, 5884.6763428011445, 5936.940630593682, 5962.373950735176, 5885.911711324334, 5886.381929897363, 5892.734826932799, 5901.114832775075, 5912.260967379078, 4956.835143741236, 5334.146536554152, 5863.413658634145, 5870.295564532241, 5878.294604647427, 4461.263891457906, 4779.617630589544, 5001.895791343212, 5071.366079240095, 5153.845384638467, 24547.0, 25034.624480632807, 25061.62407563888, 25636.35909102269, 25958.87020564904, 2322.744498105224, 2417.2748175547267, 2554.246497283287, 2624.107803346871, 2911.796174267802, 14930.47743328989, 15216.771748423782, 15424.5372638821, 16165.595860103474, 16233.944793588496, 1806.4851517317634, 1850.8796928199624, 1868.7010078387393, 1902.4863286912457, 1907.895065771382, 114255.0, 115279.42360288229, 115595.42202289018, 116150.41924790406, 117978.0, 10386.584536618451, 10410.947945260225, 10417.30185784051, 10547.525361358757, 10769.9461502692, 13312.800307995389, 13375.398107085204, 13405.0, 13410.597682069554, 13418.731625367438, 6657.0, 6955.756548520778, 8337.249647531751, 8523.65905363791, 8685.826283474295, 8523.701670441505, 8544.957275213708, 8580.742577722678, 8666.789968557978, 8699.391042627081, 6418.454431373386, 6547.410733034049, 6561.967190164019, 6578.736850526021, 6590.8352291193105, 1544.783730277762, 1784.6073863750214, 1815.1287382056687, 1828.2138680367304, 1853.7765075050402, 711.7224282529818, 809.8015986083448, 963.21016766251, 1022.5909636145452, 1024.4877561219391, 20659.380218593466, 22265.777342226695, 22350.0, 22409.775902241094, 22519.0, 845.940784145104, 946.1673727120228, 1011.9139873110721, 1017.4200705597739, 1054.1619412567027, 11306.038986686059, 11667.941660291644, 11695.707607309716, 11825.408729563487, 11877.88122118785, 546829.0, 553749.0, 560397.0, 561017.0, 562518.0, 62730.118096457176, 80959.0, 83279.58360208281, 94491.22035118518, 104318.47840760747, 940.6425558287943, 958.3243813111878, 993.2401712689798, 994.3536701144169, 995.2833959549258, 19224.0, 19721.0, 20027.792773878606, 20036.799632003494, 20083.698744519137, 30323.69676303297, 35567.822160890064, 45553.0, 46153.0, 46158.76920615375, 65798.67100664465, 65911.85159635919, 66050.03699778029, 66326.0, 67508.3249167502, 7567.962160189164, 7729.1884352142215, 7804.141544429995, 7813.492123011986, 8006.639701213576, 12356.320402377596, 12397.504099835905, 12511.56209532662, 12763.80854287205, 12889.419976101286, 10649.307794993301, 10833.783324333312, 10915.945420272848, 11149.55401783952, 11205.271657342246, 10559.155267578422, 10686.198535110054, 10696.41169735672, 10711.785764284516, 10994.725131871768, 11002.0, 11273.492692829006, 11353.943230283796, 11445.599404020819, 11529.942350288195, 6884.277150899084, 7612.276833700789, 7899.486533375312, 7940.6029698513685, 8012.158723334199, 9186.173244407768, 10829.24195306321, 10984.0, 10985.725356866142, 11002.50488728025], "value": 9352.715889853936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.4203402706974, 1559.8518140776628, 1778.1820362633189, 1911.1781933768475, 1939.3503176435884, 8142.796430089251, 8578.541647919845, 8584.570771461433, 8592.097829727882, 8597.871031934526, 7555.622218889047, 7777.805554861131, 8119.3910456715685, 8360.414770966036, 8397.748067557983, 2294.575503531848, 2328.790408863202, 2329.778671026258, 2333.7899589036983, 2335.0309621507054, 2295.2196253273883, 2305.3660243433023, 2316.6756654068445, 2346.9765302347014, 2355.7879790818824, 1947.4936516505668, 2149.8710077395326, 2286.7141607299086, 2302.470431800687, 2309.203324852923, 2276.886155692217, 2297.5979203639463, 2299.91950281741, 2299.9310020699404, 2302.113686230805, 2281.908723651052, 2288.119074156445, 2322.581935251654, 2337.0, 2340.789328960385, 8481.406301558893, 8543.444676096096, 8551.615177316973, 8557.058723540405, 8569.871451928226, 5120.462351453119, 5272.340957380327, 5273.973630131824, 5279.973600132013, 5282.788688452457, 3376.2234686022352, 3410.2497450560836, 3610.5016418186683, 3686.3733165361955, 3688.160116710145, 1049.9370037797758, 1065.1744897704264, 1070.7430216748003, 1087.3856271206744, 1094.03178187304, 8617.48295102296, 10987.230893837355, 11089.889101108967, 11146.21976461648, 11175.552977880876, 4457.197704413172, 4583.427071616048, 4673.042026384583, 4683.250679891201, 4719.693219940762, 9505.477198754135, 9531.38046027006, 9538.856917146248, 9539.570719317648, 9544.856827147598, 5249.763760630781, 5253.343332083489, 5254.448282930237, 5270.604704647167, 5272.630915835932, 3999.2601368746873, 4203.4115223868685, 4792.0895029944195, 4826.396700412449, 4829.806807727722, 3729.776213427203, 3763.6989040876665, 3812.885613431546, 3837.6162383761402, 3855.2867719471988, 1240.3178251961385, 1251.8372611560621, 1253.3044160491015, 1262.2868079535033, 1263.0, 910.2763303173992, 914.7484441778564, 924.089771574998, 934.528063328015, 967.7338731848657, 5147.613928955343, 5604.775808967595, 5639.0, 5861.238039054895, 5987.760489580455, 440.26475785438396, 932.137772560379, 1007.1690855044618, 1036.9481525923673, 1059.7403636109048, 3685.2261025184475, 3707.647773461517, 3810.5998870118237, 3980.4029395590314, 3980.681545476355, 9760.0, 10102.494875256209, 10257.17942564593, 10266.691999239885, 10289.9485502572, 9836.409815411098, 10087.344322619007, 10286.485675716185, 10292.0, 10297.691069267934, 5929.288485381696, 7601.12587052485, 7906.604669766489, 8076.192380761877, 8096.8380632387025, 5215.29593504872, 5513.614047016831, 5672.404397538364, 5705.572082093777, 5817.272840894888, 9344.859827102735, 9361.098059601545, 9383.202427793714, 9421.528923553658, 9442.38624489406, 9107.817843643223, 9617.951910240405, 9635.325527213028, 9700.0, 9705.951470242604, 6311.715972781328, 6504.934950650622, 6507.251666058274, 6733.3939945405145, 6900.3444672756, 7428.294312040348, 7567.205443428581, 7664.501807382502, 7669.7315593953945, 7996.800079998046, 6657.7669781557415, 6833.316668333326, 6857.27998560144, 6956.5478243913985, 6958.06066181059, 6229.96885015572, 7158.498905076594, 7180.892286615601, 7201.71193152268, 7257.927420725725, 6554.437692997349, 6665.700043497957, 6762.52662313653, 6764.729410823512, 6772.525923185527, 4850.417949846041, 4882.4629290777275, 4890.682105663121, 4931.827386041615, 5027.296178534935, 4841.322214889848, 4888.0, 4931.112399767932, 5011.574016208663, 5105.285260063668], "value": 4432.028137520384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.59932901988975, 275.0, 302.1268533936923, 310.1470954874096, 318.6717680788788, 4401.867943961683, 4686.90626187476, 4758.333833263346, 4791.137595232856, 5263.236830659557, 4269.231538323101, 4994.8501544953615, 5091.770870310836, 5153.407358153813, 5192.0, 3468.3410152071024, 3816.5992570780086, 3999.320115580358, 4023.5171779386515, 4028.7381320214167, 3624.7313440295816, 3767.9058023549355, 3807.3527500325013, 4007.4971885542923, 4034.7175697701173, 3223.9194020149566, 3661.212839239563, 3732.6267373262594, 3959.366501359783, 3988.940165897514, 3941.6649584785328, 3943.842246310144, 3971.6028397160344, 3975.8807235782974, 4020.336644453662, 2715.8370497770197, 3416.6241713411755, 3452.413089774719, 3455.395305821471, 3480.773749706261, 4478.208716513421, 4890.926636100461, 5050.444451110375, 5159.948400515985, 5176.663516871391, 4291.0, 4441.200583894898, 4463.152001119809, 4520.412346394947, 4534.344964088117, 5307.575393968474, 5457.645253058578, 5508.3114610673665, 5521.779128834842, 5527.668339899619, 3217.533457648651, 3635.872879407366, 3769.491118698968, 3770.736803170941, 3780.092777733352, 5073.441921388644, 5149.253358263031, 5649.576281778883, 5796.681182534959, 5823.040332573848, 3725.6460636239512, 3750.5311836020496, 3765.246950609889, 3789.317922773927, 3792.27946690128, 3044.6346438427086, 3633.400488919299, 3775.244951009809, 3871.9806400967814, 3875.7403843750894, 3682.116292089879, 3743.5694895086867, 4434.246178149722, 4502.684812063124, 4544.750503390092, 5566.972165139148, 5578.3543854563, 5578.748956296977, 5578.86052848682, 5584.301962254718, 1120.5013768872936, 1248.9750204995848, 1249.3940438887132, 1280.1949251555263, 1294.5080869269805, 651.2900937977532, 762.954222746637, 782.9686812527549, 810.3922058456158, 828.2090603473669, 4035.6367926886132, 4165.771097526237, 4245.172191422643, 4264.701470897069, 4283.785810709452, 4700.741459219776, 4721.881952951204, 4765.760092756399, 4776.259679749644, 4866.562009419169, 3837.972256344198, 3988.3419235825763, 4011.3180759270995, 4127.885470922834, 4220.831166753357, 2085.9165633374496, 2208.4492411265014, 2308.6421604651305, 2325.6976593042796, 2410.963835542468, 4358.063016451478, 4436.578525040116, 4694.694844835075, 4802.919343147833, 4830.227163653869, 3924.4898163238595, 4029.7582145071387, 4559.635229181657, 4717.693349932243, 4746.742113339968, 4109.486314210723, 4262.7016108872085, 4792.993471370912, 4847.491013443609, 4849.539293767016, 4402.581754733424, 4403.383526306384, 4719.702081927498, 4738.573528382462, 4806.879828004188, 4181.51912530063, 4420.756858372821, 4595.586397224266, 4666.743329116795, 4671.27595222741, 4292.828286868616, 4361.681934884505, 4763.356946812275, 4818.734969576707, 4868.245421959602, 2843.701411351861, 3016.743576795909, 3247.944418064186, 3249.2201871550183, 3278.377298161414, 4411.3824064630335, 4453.888652783707, 4623.42207224097, 4698.671093023456, 4699.03669747694, 5014.7994080236385, 5462.426445223195, 5530.281063461724, 5545.2513910623165, 5589.0, 4703.635945575745, 5554.611177217556, 5574.275344205227, 5599.264228089305, 5616.865591075365, 4040.717149799486, 4957.603391728725, 5233.7383130842545, 5483.7806487740045, 5542.224088627515, 4782.0, 5088.974555127201, 5165.66423182492, 5323.1216849219445, 5608.46719561641, 4861.51384861511, 4902.862168212276, 5236.842894713165, 5477.3427188737605, 5487.972560137174], "value": 3719.8971637435775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.4684659928353, 715.4991505945836, 746.5110352718964, 779.3998621061783, 827.648249493965, 12702.428390722416, 13535.932320338408, 14069.944754143442, 15142.924285378558, 15209.23953802311, 11161.553537858475, 13773.311334433263, 13803.447862085504, 13818.79271810921, 13823.0, 681.9590824550518, 701.8771714949889, 705.6789160931789, 836.8493671139223, 839.6137776622761, 845.5180547088162, 853.4537895746727, 859.8495263328924, 859.9183077607618, 861.3023451004706, 917.7246825952221, 918.0544039639183, 918.2103391083696, 920.4017388697333, 921.4102974096584, 706.7914965085312, 732.2896790113581, 909.3634455880909, 911.6535716427782, 912.5482885971453, 649.3765984654738, 668.0880597983718, 671.3018460800762, 671.5668393885916, 672.1195234243108, 14605.269736513132, 14688.926555367154, 14697.632559185999, 14713.0, 14720.558383248519, 13256.53602123921, 13373.131964141643, 13390.799138012937, 13454.529091481849, 13563.796543051763, 11986.340751258676, 12107.93946030273, 12114.273143611412, 12325.93837030818, 12696.80954785679, 4407.779611019436, 4499.775011249457, 4529.411176547061, 4541.45502539694, 4597.7011494252765, 80103.69538982685, 83507.0, 83704.74442883361, 83905.58047209786, 83935.0, 10374.429406382722, 10549.89450105489, 10589.84115238272, 10615.469226538797, 10696.197785166143, 20799.8960005199, 20802.167913283298, 20807.0, 20815.687764683542, 20844.687329690067, 7441.255874412515, 7621.31408173267, 7794.610269486503, 7801.609919504002, 7811.0, 4089.0595163112653, 4135.8966025849595, 4137.089840235143, 4183.958160418418, 4381.605655491021, 3371.5279860819505, 3470.8611655534, 3494.266204097117, 3495.528103706018, 3498.0, 625.5683578330937, 634.0, 641.2529403245167, 645.9773907913294, 656.1109696361457, 489.0732062741086, 500.39202369121693, 558.154396089924, 604.1602172979561, 607.4745345276392, 8444.704435344733, 8642.567871606394, 8862.601182946783, 8942.68700595476, 9182.716404726356, 620.500497099839, 626.5269721360344, 631.6399652198295, 647.3882181338683, 649.357136434926, 3763.303788799081, 4244.896326955014, 4358.237308471005, 4395.472543294825, 4400.317950717644, 93039.5348023269, 108992.0, 110932.89067109388, 114504.0, 116741.41629291799, 76421.61789191018, 83910.58044709737, 101944.0, 102578.48710756398, 105035.0, 87988.56005720058, 88008.5599571998, 88513.0, 90043.09956900348, 92436.53781731048, 8267.83464330722, 8494.617742201492, 8540.615672294638, 8815.382923195571, 8862.645494180419, 57048.0, 57341.0, 57938.0, 58027.0, 58826.11760823506, 76823.0, 79951.0, 81924.0, 82224.58887705523, 82717.0, 9307.953460232655, 11074.169437292074, 11118.221724479532, 11337.886621133683, 11844.46699898524, 9956.402615843073, 10445.059944605022, 11811.763764724828, 11997.520099195934, 12063.21589096706, 11339.659810205707, 11585.131115166228, 11686.18196726221, 11711.824322635337, 11845.940770296093, 11528.769424611293, 11587.536498540301, 11642.24325418845, 11661.591844285409, 12112.939435302767, 11313.434328283389, 11359.886401135884, 11404.657860264206, 11518.020968217796, 11551.0, 7966.84066318682, 8067.798305042421, 9602.991685872883, 9892.208623310262, 9892.703218903445, 8012.879806803019, 8396.32829373661, 9154.816903661756, 9310.0224476429, 9749.756256093655], "value": 7124.705537479537, "unit": "score"}], "name": "dromaeo_css", "value": 6979.175409900394, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 114.0, 114.0, 114.0, 121.0, 166.0, 162.0, 114.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 141.0, 116.0, 149.0, 113.0, 112.0, 112.0, 111.0, 142.0, 115.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 206.0, 264.0, 189.0, 183.0, 185.0, 182.0, 181.0, 180.0, 182.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 88.0, 60.0, 61.0, 61.0, 75.0, 71.0, 60.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 91.0, 71.0, 69.0, 69.0, 94.0, 68.0, 88.0, 125.0], "value": 83.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 84.0, 86.0, 84.0, 85.0, 83.0, 87.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 93.0, 92.0, 94.0, 94.0, 94.0, 93.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 91.0, 85.0, 82.0, 83.0, 86.0, 85.0, 82.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 70.0, 76.0, 74.0, 70.0, 70.0, 69.0, 69.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 91.0, 87.0, 88.0, 90.0, 88.0, 93.0, 99.0, 100.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 149.0, 149.0, 153.0, 158.0, 146.0, 146.0, 147.0, 177.0, 146.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 173.0, 171.0, 175.0, 173.0, 171.0, 172.0, 172.0, 171.0, 171.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1472.0000000000002, "alertThreshold": 2.0}]} 09:07:59 INFO - Return code: 0 09:07:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:07:59 INFO - # TBPL SUCCESS # 09:07:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:07:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:07:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:07:59 INFO - 2016-10-29 09:07:59.654 screenresolution[1939:11207] starting screenresolution argv=screenresolution get 09:07:59 INFO - 2016-10-29 09:07:59.657 screenresolution[1939:11207] Display 0: 1600x1200x32@60 09:07:59 INFO - 2016-10-29 09:07:59.664 screenresolution[1940:11210] starting screenresolution argv=screenresolution list 09:07:59 INFO - Available Modes on Display 0 09:07:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:07:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:07:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:07:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:07:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:07:59 INFO - Intel Iris: 09:07:59 INFO - Chipset Model: Intel Iris 09:07:59 INFO - Type: GPU 09:07:59 INFO - Bus: Built-In 09:07:59 INFO - VRAM (Dynamic, Max): 1536 MB 09:07:59 INFO - Vendor: Intel (0x8086) 09:07:59 INFO - Device ID: 0x0a2e 09:07:59 INFO - Revision ID: 0x0009 09:07:59 INFO - Displays: 09:07:59 INFO - Display: 09:07:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:07:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:07:59 INFO - Display Serial Number: 1600x1200 60 09:07:59 INFO - Main Display: Yes 09:07:59 INFO - Mirror: Off 09:07:59 INFO - Online: Yes 09:07:59 INFO - Rotation: Supported 09:07:59 INFO - Return code: 0 09:07:59 INFO - Running post-action listener: _resource_record_post_action 09:07:59 INFO - [mozharness: 2016-10-29 16:07:59.900408Z] Finished run-tests step (success) 09:07:59 INFO - Running post-run listener: _resource_record_post_run 09:07:59 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 2252800; Write bytes: 707929088; Read time: 19; Write time: 1953 09:07:59 INFO - TinderboxPrint: CPU usage
53.4% 09:07:59 INFO - TinderboxPrint: I/O read bytes / time
2,252,800 / 19 09:07:59 INFO - TinderboxPrint: I/O write bytes / time
707,929,088 / 1,953 09:07:59 INFO - TinderboxPrint: CPU idle
2,261.7 (46.6%) 09:07:59 INFO - TinderboxPrint: CPU system
965.6 (19.9%) 09:07:59 INFO - TinderboxPrint: CPU user
1,630.5 (33.6%) 09:07:59 INFO - TinderboxPrint: Swap in / out
409,346,048 / 0 09:07:59 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407609856; Write bytes: 410639360; Read time: 30463; Write time: 852 09:07:59 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 1351680; Write bytes: 296032256; Read time: 16; Write time: 1093 09:08:00 INFO - Running post-run listener: _upload_blobber_files 09:08:00 INFO - Blob upload gear active. 09:08:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:00 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:00 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:00 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:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:01 INFO - (blobuploader) - INFO - Done attempting. 09:08:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:02 INFO - (blobuploader) - INFO - Done attempting. 09:08:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:05 INFO - (blobuploader) - INFO - Done attempting. 09:08:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:05 INFO - Return code: 0 09:08:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ac0eb689f45e696e6e999279feba0b051e5a5018caa01686a0db204c1ee6639172f041dca98ad5384c40fbae774f7e559b8ce4cbcab85d3828b769f93bba019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75c534982b611b100665809ddc7bcb4ac45cadab419dac6e05362c129301f4a167dcb00720486dd645c92d68eebf784d36509b788540dc85f2011e6d22df781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11b718c97c93fb708fe867e325376143f940a522ae7664c03dc71a29567c7b114546333636c853ef4eddf2ebfab37511682daa747e09405a4faddc45cd8b8a24"} 09:08:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:05 INFO - Contents: 09:08:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ac0eb689f45e696e6e999279feba0b051e5a5018caa01686a0db204c1ee6639172f041dca98ad5384c40fbae774f7e559b8ce4cbcab85d3828b769f93bba019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75c534982b611b100665809ddc7bcb4ac45cadab419dac6e05362c129301f4a167dcb00720486dd645c92d68eebf784d36509b788540dc85f2011e6d22df781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11b718c97c93fb708fe867e325376143f940a522ae7664c03dc71a29567c7b114546333636c853ef4eddf2ebfab37511682daa747e09405a4faddc45cd8b8a24"} 09:08:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:05 INFO - Copying logs to upload dir... 09:08:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.386927 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-29 09:08:05.199086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:08:05.202705) ========= 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.798QYNhcMw/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.8c5UNMmsA5/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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/0ac0eb689f45e696e6e999279feba0b051e5a5018caa01686a0db204c1ee6639172f041dca98ad5384c40fbae774f7e559b8ce4cbcab85d3828b769f93bba019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75c534982b611b100665809ddc7bcb4ac45cadab419dac6e05362c129301f4a167dcb00720486dd645c92d68eebf784d36509b788540dc85f2011e6d22df781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11b718c97c93fb708fe867e325376143f940a522ae7664c03dc71a29567c7b114546333636c853ef4eddf2ebfab37511682daa747e09405a4faddc45cd8b8a24"} build_url:https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010864 build_url: 'https://queue.taskcluster.net/v1/task/M59cfAYjSD6QukUKtFNPWw/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/0ac0eb689f45e696e6e999279feba0b051e5a5018caa01686a0db204c1ee6639172f041dca98ad5384c40fbae774f7e559b8ce4cbcab85d3828b769f93bba019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d75c534982b611b100665809ddc7bcb4ac45cadab419dac6e05362c129301f4a167dcb00720486dd645c92d68eebf784d36509b788540dc85f2011e6d22df781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11b718c97c93fb708fe867e325376143f940a522ae7664c03dc71a29567c7b114546333636c853ef4eddf2ebfab37511682daa747e09405a4faddc45cd8b8a24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:08:05.235959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:08:05.236289) ========= 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.798QYNhcMw/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.8c5UNMmsA5/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.005076 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:08:05.284969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:08:05.285268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:08:05.285851) ========= ========= Total master_lag: 0.18 =========