builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0267 starttime: 1485364805.33 results: success (0) buildid: 20170125065947 builduid: bca17e3c41cb43258759a3448bff9e46 revision: 2cea7106779920aef1eb4572ed9ae9b63939a928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.328083) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.328579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.328888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.356582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.356888) ========= 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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 09:20:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-01-25 09:20:05 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135374 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.519406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.519733) ========= 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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.026447 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:05.568075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 09:20:05.571427) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2cea7106779920aef1eb4572ed9ae9b63939a928 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2cea7106779920aef1eb4572ed9ae9b63939a928 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7VW2joXVVS/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.qEUiaJ5HAF/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 09:20:05,668 truncating revision to first 12 chars 2017-01-25 09:20:05,668 Setting DEBUG logging. 2017-01-25 09:20:05,668 attempt 1/10 2017-01-25 09:20:05,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2cea71067799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 09:20:07,303 unpacking tar archive at: mozilla-beta-2cea71067799/testing/mozharness/ program finished with exit code 0 elapsedTime=1.886761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 09:20:07.480954) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:07.484318) ========= script_repo_revision: 2cea7106779920aef1eb4572ed9ae9b63939a928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:07.484742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:07.485016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 09:20:07.504703) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-25 09:20:07.504978) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7VW2joXVVS/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.qEUiaJ5HAF/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:20:07 INFO - MultiFileLogger online at 20170125 09:20:07 in /builds/slave/test 09:20:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:20:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:07 INFO - {'append_to_log': False, 09:20:07 INFO - 'base_work_dir': '/builds/slave/test', 09:20:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:20:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:07 INFO - 'branch': 'Mozilla-Beta', 09:20:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:07 INFO - 'config_files': ('talos/mac_config.py',), 09:20:07 INFO - 'default_actions': ('clobber', 09:20:07 INFO - 'read-buildbot-config', 09:20:07 INFO - 'download-and-extract', 09:20:07 INFO - 'populate-webroot', 09:20:07 INFO - 'create-virtualenv', 09:20:07 INFO - 'install', 09:20:07 INFO - 'run-tests'), 09:20:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:07 INFO - 'download_minidump_stackwalk': True, 09:20:07 INFO - 'download_symbols': 'ondemand', 09:20:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:07 INFO - 'installer_path': 'installer.exe', 09:20:07 INFO - 'log_level': 'info', 09:20:07 INFO - 'log_name': 'talos', 09:20:07 INFO - 'log_to_console': True, 09:20:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:20:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:20:07 INFO - 'opt_config_files': (), 09:20:07 INFO - 'pip_index': False, 09:20:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:07 INFO - 'cmd': ('bash', 09:20:07 INFO - '-c', 09:20:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:07 INFO - 'enabled': True, 09:20:07 INFO - 'halt_on_failure': False, 09:20:07 INFO - 'name': 'check_screen_resolution'},), 09:20:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:07 INFO - 'cmd': ('bash', 09:20:07 INFO - '-c', 09:20:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:07 INFO - 'enabled': True, 09:20:07 INFO - 'halt_on_failure': False, 09:20:07 INFO - 'name': 'check_screen_resolution'},), 09:20:07 INFO - 'run_cmd_checks_enabled': True, 09:20:07 INFO - 'sps_profile': False, 09:20:07 INFO - 'sps_profile_interval': 0, 09:20:07 INFO - 'suite': 'dromaeojs', 09:20:07 INFO - 'system_bits': '32', 09:20:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:07 INFO - 'title': 't-yosemite-r7-0267', 09:20:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:07 INFO - 'use_talos_json': True, 09:20:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:07 INFO - 'work_dir': 'build'} 09:20:07 INFO - [mozharness: 2017-01-25 17:20:07.708464Z] Running clobber step. 09:20:07 INFO - Running pre-action listener: _resource_record_pre_action 09:20:07 INFO - Running main action method: clobber 09:20:07 INFO - rmtree: /builds/slave/test/build 09:20:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:09 INFO - Running post-action listener: _resource_record_post_action 09:20:09 INFO - [mozharness: 2017-01-25 17:20:09.078542Z] Finished clobber step (success) 09:20:09 INFO - [mozharness: 2017-01-25 17:20:09.078702Z] Running read-buildbot-config step. 09:20:09 INFO - Running pre-action listener: _resource_record_pre_action 09:20:09 INFO - Running main action method: read_buildbot_config 09:20:09 INFO - Using buildbot properties: 09:20:09 INFO - { 09:20:09 INFO - "project": "", 09:20:09 INFO - "product": "firefox", 09:20:09 INFO - "script_repo_revision": "production", 09:20:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:20:09 INFO - "repository": "", 09:20:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:20:09 INFO - "buildid": "20170125065947", 09:20:09 INFO - "pgo_build": "False", 09:20:09 INFO - "basedir": "/builds/slave/test", 09:20:09 INFO - "buildnumber": 9, 09:20:09 INFO - "slavename": "t-yosemite-r7-0267", 09:20:09 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:20:09 INFO - "platform": "yosemite_r7", 09:20:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:20:09 INFO - "branch": "mozilla-beta", 09:20:09 INFO - "repo_path": "releases/mozilla-beta", 09:20:09 INFO - "revision": "2cea7106779920aef1eb4572ed9ae9b63939a928", 09:20:09 INFO - "stage_platform": "macosx64", 09:20:09 INFO - "builduid": "bca17e3c41cb43258759a3448bff9e46", 09:20:09 INFO - "slavebuilddir": "test" 09:20:09 INFO - } 09:20:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:20:09 INFO - Running post-action listener: _resource_record_post_action 09:20:09 INFO - [mozharness: 2017-01-25 17:20:09.081994Z] Finished read-buildbot-config step (success) 09:20:09 INFO - [mozharness: 2017-01-25 17:20:09.082118Z] Running download-and-extract step. 09:20:09 INFO - Running pre-action listener: _resource_record_pre_action 09:20:09 INFO - Running main action method: download_and_extract 09:20:09 INFO - mkdir: /builds/slave/test/build/tests 09:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:09 INFO - trying https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:20:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:20:11 INFO - Downloaded 1165 bytes. 09:20:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:20:11 INFO - Using the following test package requirements: 09:20:11 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:20:11 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:20:11 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:20:11 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:20:11 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:20:11 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:20:11 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:20:11 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:20:11 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:20:11 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:20:11 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:20:11 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:20:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:20:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:20:11 INFO - Fetch https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:20:12 INFO - Http code: 200 09:20:12 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 09:20:12 INFO - x-amz-cf-id: wnQqYGINXzI6YoTC-jizs4CJFBZf_3bE3llpqE-Fyz7htoaiAXrzcA== 09:20:12 INFO - x-amz-version-id: .bqQTauSsxoENxCOfrfbmL8RpDNJ8gzM 09:20:12 INFO - Expected file size: 16086213 09:20:12 INFO - Obtained file size: 16086213 09:20:19 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:20:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:20:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:20:19 INFO - Fetch https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:20:19 INFO - Http code: 200 09:20:19 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:20:19 INFO - x-amz-cf-id: oSPxEr9HsPiL2FCT2AAvRcV3Vkqt4s-Uyc9yVbZRmOMdVftJp3WHHg== 09:20:19 INFO - x-amz-version-id: .bqQTauSsxoENxCOfrfbmL8RpDNJ8gzM 09:20:19 INFO - Expected file size: 16086213 09:20:19 INFO - Obtained file size: 16086213 09:20:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:20:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:20:26 INFO - Fetch https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:20:27 INFO - Http code: 200 09:20:27 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 09:20:27 INFO - x-amz-cf-id: tchTrAOIx37-VWINCPZaL8cla6GlBYRm_-EB0Mqk9Kq4Ikuvhw44OQ== 09:20:27 INFO - x-amz-version-id: Z.u804wweO4gHhBe4QWSBT4QRPlf4emF 09:20:27 INFO - Expected file size: 14402992 09:20:27 INFO - Obtained file size: 14402992 09:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:27 INFO - trying https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:20:27 INFO - Downloading https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:20:29 INFO - Downloaded 82124699 bytes. 09:20:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:20:29 INFO - mkdir: /builds/slave/test/properties 09:20:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:29 INFO - Contents: 09:20:29 INFO - build_url:https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:20:30 INFO - Running post-action listener: _resource_record_post_action 09:20:30 INFO - Running post-action listener: set_extra_try_arguments 09:20:30 INFO - [mozharness: 2017-01-25 17:20:30.677802Z] Finished download-and-extract step (success) 09:20:30 INFO - [mozharness: 2017-01-25 17:20:30.677944Z] Running populate-webroot step. 09:20:30 INFO - Running pre-action listener: _resource_record_pre_action 09:20:30 INFO - Running main action method: populate_webroot 09:20:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:30 INFO - '--tppagecycles', 09:20:30 INFO - '7'], 09:20:30 INFO - 'tests': ['tsvgm']}}, 09:20:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:20:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:20:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:20:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['damp', 'tps']}, 09:20:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'tests': ['damp', 'tps']}, 09:20:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['dromaeo_dom']}, 09:20:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['basic_compositor_video']}, 09:20:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:20:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['a11yr', 09:20:30 INFO - 'ts_paint', 09:20:30 INFO - 'tpaint', 09:20:30 INFO - 'sessionrestore', 09:20:30 INFO - 'sessionrestore_no_auto_restore', 09:20:30 INFO - 'tabpaint']}, 09:20:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:20:30 INFO - 'ts_paint', 09:20:30 INFO - 'tpaint', 09:20:30 INFO - 'sessionrestore', 09:20:30 INFO - 'sessionrestore_no_auto_restore', 09:20:30 INFO - 'tabpaint']}, 09:20:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:20:30 INFO - 'ts_paint', 09:20:30 INFO - 'tpaint', 09:20:30 INFO - 'sessionrestore', 09:20:30 INFO - 'sessionrestore_no_auto_restore', 09:20:30 INFO - 'tabpaint']}, 09:20:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:20:30 INFO - 'ts_paint', 09:20:30 INFO - 'tpaint', 09:20:30 INFO - 'sessionrestore', 09:20:30 INFO - 'sessionrestore_no_auto_restore', 09:20:30 INFO - 'tabpaint']}, 09:20:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['a11yr', 09:20:30 INFO - 'ts_paint', 09:20:30 INFO - 'tpaint', 09:20:30 INFO - 'sessionrestore', 09:20:30 INFO - 'sessionrestore_no_auto_restore', 09:20:30 INFO - 'tabpaint']}, 09:20:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['a11yr', 09:20:30 INFO - 'ts_paint', 09:20:30 INFO - 'tpaint', 09:20:30 INFO - 'sessionrestore', 09:20:30 INFO - 'sessionrestore_no_auto_restore', 09:20:30 INFO - 'tabpaint']}, 09:20:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['tsvgx', 09:20:30 INFO - 'tsvgr_opacity', 09:20:30 INFO - 'tart', 09:20:30 INFO - 'tscrollx', 09:20:30 INFO - 'cart']}, 09:20:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:20:30 INFO - 'tsvgr_opacity', 09:20:30 INFO - 'tart', 09:20:30 INFO - 'tscrollx', 09:20:30 INFO - 'cart']}, 09:20:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'talos_options': ['--disable-e10s'], 09:20:30 INFO - 'tests': ['tp5o']}, 09:20:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'tests': ['tp5o']}, 09:20:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'talos_options': ['--disable-e10s', 09:20:30 INFO - '--xperf_path', 09:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:30 INFO - 'tests': ['tp5n']}, 09:20:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:20:30 INFO - 'talos_options': ['--xperf_path', 09:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:30 INFO - 'tests': ['tp5n']}}, 09:20:30 INFO - 'talos.zip': {'path': '', 09:20:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:30 INFO - Running post-action listener: _resource_record_post_action 09:20:30 INFO - [mozharness: 2017-01-25 17:20:30.696362Z] Finished populate-webroot step (success) 09:20:30 INFO - [mozharness: 2017-01-25 17:20:30.696467Z] Running create-virtualenv step. 09:20:30 INFO - Running pre-action listener: _resource_record_pre_action 09:20:30 INFO - Running main action method: create_virtualenv 09:20:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:20:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:30 INFO - Using real prefix '/tools/python27' 09:20:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:34 INFO - Installing pip.................done. 09:20:34 INFO - Return code: 0 09:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:20:34 INFO - Reading from file tmpfile_stdout 09:20:34 INFO - Output received: 09:20:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:20:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:34 INFO - 'HOME': '/Users/cltbld', 09:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:34 INFO - 'LOGNAME': 'cltbld', 09:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:34 INFO - 'MOZ_NO_REMOTE': '1', 09:20:34 INFO - 'NO_EM_RESTART': '1', 09:20:34 INFO - 'PAGER': '/bin/cat', 09:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:34 INFO - 'PWD': '/builds/slave/test', 09:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:34 INFO - 'SHELL': '/bin/bash', 09:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:34 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:34 INFO - 'USER': 'cltbld', 09:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:34 INFO - 'XPC_FLAGS': '0x0', 09:20:34 INFO - 'XPC_SERVICE_NAME': '0', 09:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:20:34 INFO - Cleaning up... 09:20:34 INFO - Return code: 0 09:20:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:34 INFO - 'HOME': '/Users/cltbld', 09:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:34 INFO - 'LOGNAME': 'cltbld', 09:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:34 INFO - 'MOZ_NO_REMOTE': '1', 09:20:34 INFO - 'NO_EM_RESTART': '1', 09:20:34 INFO - 'PAGER': '/bin/cat', 09:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:34 INFO - 'PWD': '/builds/slave/test', 09:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:34 INFO - 'SHELL': '/bin/bash', 09:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:34 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:34 INFO - 'USER': 'cltbld', 09:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:34 INFO - 'XPC_FLAGS': '0x0', 09:20:34 INFO - 'XPC_SERVICE_NAME': '0', 09:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:35 INFO - Downloading/unpacking psutil>=3.1.1 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:38 INFO - Installing collected packages: psutil 09:20:38 INFO - Running setup.py install for psutil 09:20:38 INFO - building 'psutil._psutil_osx' extension 09:20:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:20:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:20:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:20:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:20:39 INFO - building 'psutil._psutil_posix' extension 09:20:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:20:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:20:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:20:39 INFO - ^ 09:20:39 INFO - 1 warning generated. 09:20:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:39 INFO - Successfully installed psutil 09:20:39 INFO - Cleaning up... 09:20:39 INFO - Return code: 0 09:20:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:20:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:39 INFO - 'HOME': '/Users/cltbld', 09:20:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:39 INFO - 'LOGNAME': 'cltbld', 09:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:39 INFO - 'MOZ_NO_REMOTE': '1', 09:20:39 INFO - 'NO_EM_RESTART': '1', 09:20:39 INFO - 'PAGER': '/bin/cat', 09:20:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:39 INFO - 'PWD': '/builds/slave/test', 09:20:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:39 INFO - 'SHELL': '/bin/bash', 09:20:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:39 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:39 INFO - 'USER': 'cltbld', 09:20:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:39 INFO - 'XPC_FLAGS': '0x0', 09:20:39 INFO - 'XPC_SERVICE_NAME': '0', 09:20:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:20:43 INFO - Installing collected packages: mozsystemmonitor 09:20:43 INFO - Running setup.py install for mozsystemmonitor 09:20:43 INFO - Successfully installed mozsystemmonitor 09:20:43 INFO - Cleaning up... 09:20:43 INFO - Return code: 0 09:20:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:43 INFO - 'HOME': '/Users/cltbld', 09:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:43 INFO - 'LOGNAME': 'cltbld', 09:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:43 INFO - 'MOZ_NO_REMOTE': '1', 09:20:43 INFO - 'NO_EM_RESTART': '1', 09:20:43 INFO - 'PAGER': '/bin/cat', 09:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:43 INFO - 'PWD': '/builds/slave/test', 09:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:43 INFO - 'SHELL': '/bin/bash', 09:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:43 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:43 INFO - 'USER': 'cltbld', 09:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:43 INFO - 'XPC_FLAGS': '0x0', 09:20:43 INFO - 'XPC_SERVICE_NAME': '0', 09:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:43 INFO - Downloading/unpacking jsonschema==2.5.1 09:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:20:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:20:46 INFO - warning: no files found matching '*.txt' 09:20:46 INFO - no previously-included directories found matching 'build' 09:20:46 INFO - no previously-included directories found matching 'dist' 09:20:46 INFO - no previously-included directories found matching '.git*' 09:20:46 INFO - Installing collected packages: jsonschema, functools32 09:20:46 INFO - Running setup.py install for functools32 09:20:46 INFO - warning: no files found matching '*.txt' 09:20:46 INFO - no previously-included directories found matching 'build' 09:20:46 INFO - no previously-included directories found matching 'dist' 09:20:46 INFO - no previously-included directories found matching '.git*' 09:20:46 INFO - Successfully installed jsonschema functools32 09:20:46 INFO - Cleaning up... 09:20:46 INFO - Return code: 0 09:20:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:46 INFO - 'HOME': '/Users/cltbld', 09:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:46 INFO - 'LOGNAME': 'cltbld', 09:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:46 INFO - 'MOZ_NO_REMOTE': '1', 09:20:46 INFO - 'NO_EM_RESTART': '1', 09:20:46 INFO - 'PAGER': '/bin/cat', 09:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:46 INFO - 'PWD': '/builds/slave/test', 09:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:46 INFO - 'SHELL': '/bin/bash', 09:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:46 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:46 INFO - 'USER': 'cltbld', 09:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:46 INFO - 'XPC_FLAGS': '0x0', 09:20:46 INFO - 'XPC_SERVICE_NAME': '0', 09:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:20:47 INFO - Cleaning up... 09:20:47 INFO - Return code: 0 09:20:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:47 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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:47 INFO - 'HOME': '/Users/cltbld', 09:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:47 INFO - 'LOGNAME': 'cltbld', 09:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:47 INFO - 'MOZ_NO_REMOTE': '1', 09:20:47 INFO - 'NO_EM_RESTART': '1', 09:20:47 INFO - 'PAGER': '/bin/cat', 09:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:47 INFO - 'PWD': '/builds/slave/test', 09:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:47 INFO - 'SHELL': '/bin/bash', 09:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:47 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:47 INFO - 'USER': 'cltbld', 09:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:47 INFO - 'XPC_FLAGS': '0x0', 09:20:47 INFO - 'XPC_SERVICE_NAME': '0', 09:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:51 INFO - Downloading docopt-0.6.1.tar.gz 09:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:51 INFO - Running setup.py install for blobuploader 09:20:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:51 INFO - Running setup.py install for requests 09:20:52 INFO - Running setup.py install for docopt 09:20:52 INFO - Successfully installed blobuploader requests docopt 09:20:52 INFO - Cleaning up... 09:20:52 INFO - Return code: 0 09:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:52 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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:52 INFO - 'HOME': '/Users/cltbld', 09:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:52 INFO - 'LOGNAME': 'cltbld', 09:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:52 INFO - 'MOZ_NO_REMOTE': '1', 09:20:52 INFO - 'NO_EM_RESTART': '1', 09:20:52 INFO - 'PAGER': '/bin/cat', 09:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:52 INFO - 'PWD': '/builds/slave/test', 09:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:52 INFO - 'SHELL': '/bin/bash', 09:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:52 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:52 INFO - 'USER': 'cltbld', 09:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:52 INFO - 'XPC_FLAGS': '0x0', 09:20:52 INFO - 'XPC_SERVICE_NAME': '0', 09:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-6d0n3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-Z8uIJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-lpfzxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-A4teIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:52 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-uNj_09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-OeUEyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-KJljWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-7w7Hqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-yRUse1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-duKprM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-TaSuYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-oD9m7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-cCKDQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-2yFXkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:53 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-doogBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:54 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-xtHAPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:54 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-P7t2bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:54 INFO - Running setup.py install for manifestparser 09:20:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:54 INFO - Running setup.py install for mozcrash 09:20:54 INFO - Running setup.py install for mozdebug 09:20:54 INFO - Running setup.py install for mozdevice 09:20:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:20:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:54 INFO - Running setup.py install for mozfile 09:20:55 INFO - Running setup.py install for mozhttpd 09:20:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Running setup.py install for mozinfo 09:20:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Running setup.py install for mozInstall 09:20:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Running setup.py install for mozleak 09:20:55 INFO - Running setup.py install for mozlog 09:20:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Running setup.py install for moznetwork 09:20:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:55 INFO - Running setup.py install for mozprocess 09:20:56 INFO - Running setup.py install for mozprofile 09:20:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:56 INFO - Running setup.py install for mozrunner 09:20:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:56 INFO - Running setup.py install for mozscreenshot 09:20:56 INFO - Running setup.py install for moztest 09:20:56 INFO - Running setup.py install for mozversion 09:20:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:56 INFO - Cleaning up... 09:20:56 INFO - Return code: 0 09:20:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:56 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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:20:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:20:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:56 INFO - 'HOME': '/Users/cltbld', 09:20:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:56 INFO - 'LOGNAME': 'cltbld', 09:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:56 INFO - 'MOZ_NO_REMOTE': '1', 09:20:56 INFO - 'NO_EM_RESTART': '1', 09:20:56 INFO - 'PAGER': '/bin/cat', 09:20:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:56 INFO - 'PWD': '/builds/slave/test', 09:20:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:56 INFO - 'SHELL': '/bin/bash', 09:20:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:20:56 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:20:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:56 INFO - 'USER': 'cltbld', 09:20:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:56 INFO - 'XPC_FLAGS': '0x0', 09:20:56 INFO - 'XPC_SERVICE_NAME': '0', 09:20:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-TexU97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-xS1z0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-yxIdOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-nDjW1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-8KQe6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-3sRR6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-EdDtoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-iTq4tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:57 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_ZV9k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-BEf_AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-LCc1Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-BmBAyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-H93NFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-D7xPmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-vuvUHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-a9xn5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:58 INFO - Running setup.py (path:/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/pip-_dh3Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:01 INFO - Downloading blessings-1.6.tar.gz 09:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:01 INFO - Installing collected packages: blessings 09:21:01 INFO - Running setup.py install for blessings 09:21:01 INFO - Successfully installed blessings 09:21:01 INFO - Cleaning up... 09:21:01 INFO - Return code: 0 09:21:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:02 INFO - Reading from file tmpfile_stdout 09:21:02 INFO - Current package versions: 09:21:02 INFO - blessings == 1.6 09:21:02 INFO - blobuploader == 1.2.4 09:21:02 INFO - docopt == 0.6.1 09:21:02 INFO - functools32 == 3.2.3-2 09:21:02 INFO - jsonschema == 2.5.1 09:21:02 INFO - manifestparser == 1.1 09:21:02 INFO - mozInstall == 1.12 09:21:02 INFO - mozcrash == 1.0 09:21:02 INFO - mozdebug == 0.1 09:21:02 INFO - mozdevice == 0.48 09:21:02 INFO - mozfile == 1.2 09:21:02 INFO - mozhttpd == 0.7 09:21:02 INFO - mozinfo == 0.9 09:21:02 INFO - mozleak == 0.1 09:21:02 INFO - mozlog == 3.4 09:21:02 INFO - moznetwork == 0.27 09:21:02 INFO - mozprocess == 0.23 09:21:02 INFO - mozprofile == 0.28 09:21:02 INFO - mozrunner == 6.13 09:21:02 INFO - mozscreenshot == 0.1 09:21:02 INFO - mozsystemmonitor == 0.3 09:21:02 INFO - moztest == 0.8 09:21:02 INFO - mozversion == 1.4 09:21:02 INFO - psutil == 3.1.1 09:21:02 INFO - requests == 1.2.3 09:21:02 INFO - wsgiref == 0.1.2 09:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:03 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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:03 INFO - 'HOME': '/Users/cltbld', 09:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:03 INFO - 'LOGNAME': 'cltbld', 09:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:03 INFO - 'MOZ_NO_REMOTE': '1', 09:21:03 INFO - 'NO_EM_RESTART': '1', 09:21:03 INFO - 'PAGER': '/bin/cat', 09:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:03 INFO - 'PWD': '/builds/slave/test', 09:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:03 INFO - 'SHELL': '/bin/bash', 09:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:21:03 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:03 INFO - 'USER': 'cltbld', 09:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:03 INFO - 'XPC_FLAGS': '0x0', 09:21:03 INFO - 'XPC_SERVICE_NAME': '0', 09:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:21:03 INFO - Cleaning up... 09:21:03 INFO - Return code: 0 09:21:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:03 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 0x10a79f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a715570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99e1d68bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, '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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:03 INFO - 'HOME': '/Users/cltbld', 09:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:03 INFO - 'LOGNAME': 'cltbld', 09:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:03 INFO - 'MOZ_NO_REMOTE': '1', 09:21:03 INFO - 'NO_EM_RESTART': '1', 09:21:03 INFO - 'PAGER': '/bin/cat', 09:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:03 INFO - 'PWD': '/builds/slave/test', 09:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:03 INFO - 'SHELL': '/bin/bash', 09:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:21:03 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:03 INFO - 'USER': 'cltbld', 09:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:03 INFO - 'XPC_FLAGS': '0x0', 09:21:03 INFO - 'XPC_SERVICE_NAME': '0', 09:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:03 INFO - Cleaning up... 09:21:03 INFO - Return code: 0 09:21:03 INFO - Running post-action listener: _resource_record_post_action 09:21:03 INFO - Running post-action listener: _start_resource_monitoring 09:21:03 INFO - Starting resource monitoring. 09:21:03 INFO - [mozharness: 2017-01-25 17:21:03.992597Z] Finished create-virtualenv step (success) 09:21:03 INFO - [mozharness: 2017-01-25 17:21:03.993564Z] Running install step. 09:21:03 INFO - Running pre-action listener: _resource_record_pre_action 09:21:03 INFO - Running main action method: install 09:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:04 INFO - Reading from file tmpfile_stdout 09:21:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:04 INFO - Reading from file tmpfile_stdout 09:21:04 INFO - Output received: 09:21:04 INFO - Usage: mozinstall [options] installer 09:21:04 INFO - Options: 09:21:04 INFO - -h, --help show this help message and exit 09:21:04 INFO - -d DEST, --destination=DEST 09:21:04 INFO - Directory to install application into. [default: 09:21:04 INFO - "/builds/slave/test"] 09:21:04 INFO - --app=APP Application being installed. [default: firefox] 09:21:04 INFO - mkdir: /builds/slave/test/build/application 09:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:21:25 INFO - Reading from file tmpfile_stdout 09:21:25 INFO - Output received: 09:21:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:21:25 INFO - Running post-action listener: _resource_record_post_action 09:21:25 INFO - [mozharness: 2017-01-25 17:21:25.912380Z] Finished install step (success) 09:21:25 INFO - [mozharness: 2017-01-25 17:21:25.912543Z] Running run-tests step. 09:21:25 INFO - Running pre-action listener: _resource_record_pre_action 09:21:25 INFO - Running main action method: run_tests 09:21:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:25 INFO - 2017-01-25 09:21:25.927 screenresolution[1625:7409] starting screenresolution argv=screenresolution get 09:21:25 INFO - 2017-01-25 09:21:25.930 screenresolution[1625:7409] Display 0: 1600x1200x32@60 09:21:25 INFO - 2017-01-25 09:21:25.935 screenresolution[1626:7411] starting screenresolution argv=screenresolution list 09:21:25 INFO - Available Modes on Display 0 09:21:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:26 INFO - Intel Iris: 09:21:26 INFO - Chipset Model: Intel Iris 09:21:26 INFO - Type: GPU 09:21:26 INFO - Bus: Built-In 09:21:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:26 INFO - Vendor: Intel (0x8086) 09:21:26 INFO - Device ID: 0x0a2e 09:21:26 INFO - Revision ID: 0x0009 09:21:26 INFO - Displays: 09:21:26 INFO - Display: 09:21:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:26 INFO - Display Serial Number: 1600x1200 60 09:21:26 INFO - Main Display: Yes 09:21:26 INFO - Mirror: Off 09:21:26 INFO - Online: Yes 09:21:26 INFO - Rotation: Supported 09:21:26 INFO - Return code: 0 09:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:26 INFO - Python 2.7.3 09:21:26 INFO - Return code: 0 09:21:26 INFO - grabbing minidump binary from tooltool 09:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:26 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 0x10a5b3d30>, '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 0x10a419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a5abb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:21:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:21:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:21:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:26 INFO - Return code: 0 09:21:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:21:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:21:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0267 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7VW2joXVVS/Render', 09:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:26 INFO - 'HOME': '/Users/cltbld', 09:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:26 INFO - 'LOGNAME': 'cltbld', 09:21:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:26 INFO - 'MOZ_NO_REMOTE': '1', 09:21:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:26 INFO - 'NO_EM_RESTART': '1', 09:21:26 INFO - 'PAGER': '/bin/cat', 09:21:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:26 INFO - 'PWD': '/builds/slave/test', 09:21:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:26 INFO - 'SHELL': '/bin/bash', 09:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qEUiaJ5HAF/Listeners', 09:21:26 INFO - 'TMPDIR': '/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/', 09:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:26 INFO - 'USER': 'cltbld', 09:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:26 INFO - 'XPC_FLAGS': '0x0', 09:21:26 INFO - 'XPC_SERVICE_NAME': '0', 09:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0267', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:21:26 INFO - mozversion application_buildid: 20170125065947 09:21:26 INFO - mozversion application_changeset: 2cea7106779920aef1eb4572ed9ae9b63939a928 09:21:26 INFO - mozversion application_display_name: Firefox 09:21:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:26 INFO - mozversion application_name: Firefox 09:21:26 INFO - mozversion application_remotingname: firefox 09:21:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:21:26 INFO - mozversion application_vendor: Mozilla 09:21:26 INFO - mozversion application_version: 52.0 09:21:26 INFO - mozversion platform_buildid: 20170125065947 09:21:26 INFO - mozversion platform_changeset: 2cea7106779920aef1eb4572ed9ae9b63939a928 09:21:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:21:26 INFO - mozversion platform_version: 52.0 09:21:26 INFO - using testdate: 1485364886 09:21:26 INFO - actual date: 1485364886 09:21:26 INFO - starting webserver on 'localhost:49248' 09:21:26 INFO - SUITE-START | Running 2 tests 09:21:26 INFO - TEST-START | dromaeo_css 09:21:26 INFO - operating with platform_type : mac_ 09:21:26 INFO - Initialising browser for dromaeo_css test... 09:21:26 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmp1zFb62/profile http://localhost:49248/getInfo.html) 09:21:28 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 09:21:28 INFO - PROCESS | 1636 | colorDepth:24 09:21:28 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 09:21:28 INFO - PROCESS | 1636 | __metrics 09:21:29 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:21:29 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:29 INFO - TEST-INFO | 1636: exit 0 09:21:29 INFO - Browser initialized. 09:21:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:29 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmp1zFb62/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:41 INFO - PROCESS | 1639 | RSS: Main: 171712512 09:21:41 INFO - PROCESS | 1639 | 09:24:45 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 09:24:47 INFO - PROCESS | 1639 | RSS: Main: 269254656 09:24:47 INFO - PROCESS | 1639 | 09:27:50 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 09:27:50 INFO - PROCESS | 1639 | RSS: Main: 298708992 09:27:50 INFO - PROCESS | 1639 | 09:30:53 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 09:30:53 INFO - PROCESS | 1639 | RSS: Main: 274456576 09:30:53 INFO - PROCESS | 1639 | 09:33:56 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 09:33:56 INFO - PROCESS | 1639 | RSS: Main: 282308608 09:33:56 INFO - PROCESS | 1639 | 09:36:59 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 09:37:00 INFO - PROCESS | 1639 | RSS: Main: 260550656 09:37:00 INFO - PROCESS | 1639 | 09:40:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 09:40:04 INFO - PROCESS | 1639 | RSS: Main: 537587712 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | __start_tp_report 09:40:04 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 09:40:04 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 09:40:04 INFO - PROCESS | 1639 | |i|pagename|runs| 09:40:04 INFO - PROCESS | 1639 | |0;dojo.html;3455.792652440852;3456.2569047654756;3474.6351633078534;3481.3907566175913;3529.4352903535423;5781.959247335478;5802.245708057957;5803.854903627406;5806.332271788746;5858.150568167618;5762.683052432115;5825.417458254173;5827.970860145704;5829.650220986744;5829.8834023319505;5211.609129315307;5220.347456567929;5251.501107394811;5288.867778305535;5329.227262047001;4271.8718438446895;4493.3484644726495;5187.792488300463;5204.843854684365;5231.450697676727;5229.869253268661;5252;5278.498542638443;5297.947020529803;5301.3373328333955;5248.448912864133;5274.841754747364;5335.8132465363915;5336.786528538853;5348.759305831247;5144.485551444863;5216.843494695166;5279.947200527984;5290.947090529084;5313.388960269541;5672.574556908207;5699.088145896637;5703.287089113861;5716.885662286731;5797.130430435426;6203.069539569055;6243.594166379171;6335.429811317003;6338.080978258126;6345.079963405326;6225.688715564249;6327.367263273636;6388.39310265524;6392.041193820917;6392.616443013434;5767.798127065533;5840.88318233633;5883.499902508249;5946.970265148647;5955;6319.593427543223;6330.936690633035;6340.841478963062;6341.524385671093;6374.203224596926;6093.725782339805;6265.624062556261;6273.7176827042895;6295.401936815995;6298.622082675054;6248.593841400295;6258.655773932477;6304.338044505353;6318.494520438354;6323.620582765049;6212.223472065992;6238.594491358138;6284.811455656338;6368.713407896563;6377.7767778127545;6297.1813664223355;6345.714442850082;6356.586821856565;6358.904616430757;6379.64911929839;4914.557689807934;4949.851504454872;5020.347354843847;5034.244863270539;5054.848354549369;4463.598276155161;4482.058767658763;4505.144022635689;4523.796429160696;4526;5895.823125306248;5914.142449344821;5931.347551769302;5935.020721580977;5970.731317090741;6198.566100372931;6345.143405640272;6353.5870168438905;6385.138006369174;6403.103565500834;5687.289088863892;5769.480746732815;5820.30156381237;5877.823665290048;5917.52659787216;5486.945130548644;5490.368607610176;5502.944970550323;5512.944870551323;5532.640378375393;5346.759395827197;6381.202349706286;6397.0404439332615;6407.647579383085;6412.35876412355;6218.31598524171;6219.129321895029;6239.126522286792;6269.811905642838;6375.649339286384;6288.339724328879;6321.1782468278825;6331.936680633319;6357;6370.585911915896;6290.9056364155485;6319.46284565817;6323.652199129092;6328.651924144032;6335.2714437838395;5813.476787089182;6145.324014358328;6258;6360.681965901779;6380.234371875405;6106.885399019288;6121.87979361315;6153.815385538441;6239.282482514387;6252.155958945484;6017.007193812972;6209;6238.594491358047;6239;6240.313565507699;5903.970480147572;6006.279246490449;6020.8795824084145;6089.725962331617;6090.725917333642;5067.923981140212;6115.027386288435;6124.663143527148;6136.110264011782;6241.407066328873;6090.40666007058;6098.176746139215;6103.14402883062;6117.724702388314;6132.509399247961 09:40:04 INFO - PROCESS | 1639 | |1;ext.html;490.88218827481415;520.0794593569382;543.7390052774668;549.9532539734122;554.2517601238327;33455.16362090946;35753.64246357536;38933.805330973344;40070.59929400705;40367.39448908265;39431.21137577254;41941.74174774754;42306.576934230645;42436.787816060954;42549.787251063775;9628.470434126139;9823.066808653202;9826.70519884401;9827.754306142333;9828.950855245714;9639.180669643089;9765.267604929622;9770.90229097707;9774.413535187876;9782.168515676176;9776.973417791136;9826.803463930717;9827.312088153796;9827.803443931118;9858.112769850712;9722;9781.951090244575;9788.755281117958;9789.021097890225;9791.265655075898;9639.518024098767;9722.562484688206;9723.513824308757;9724.562394692255;9734.951325243399;39290.60709392927;39660;39672.60327396718;39685;39705.80882573499;3550.254446566224;3592.0840185752727;3618.8914332569802;3983.521977362706;4140.964758810297;29369;29860.402791944256;30226.697733022607;30235;31175.84412077925;3191.7446604271604;3198.296374797541;3297.3075654112663;3299.8185099819502;3348.313595712873;512398;513332.43333783466;513470;514346;515692;55852;56037.59906002301;56135.71932140313;56251;56291.71854140785;34659.82670086633;35515.82242088773;35550.11124721903;36338.27323453516;36397.45403818945;15633.60915977087;15749.842501574838;15760.605984850241;15769.211539422982;15776.60558486047;12698.80951785724;12810;12811.295378754072;12819.294938778457;12832.743345133045;18194.270859370936;18410.81589184091;18451;18558.44324670262;18711.625767484573;6746.494012949049;7805.2194780521495;7815.843683126305;7873.291403773688;7883.9605801971775;880.348542078857;974.9616658258932;982.4400091947522;1062.176812969939;1100.0374672161859;27047.323816904736;28614.71385286162;29111;29442.852785736362;29748.851255743582;1040.7450174707244;1071.7588542578014;1094.3543309447305;1098.5386137822134;1107.1198397274025;14400.711985760227;14831.77752333716;14913.850861491463;15057.096574205583;15463.845361546466;690141;762720;775447;775933;777394;58855.411445884994;59562.702186488794;59702.70148649229;63461.68269158625;63489.68255158787;1325.443313808203;1365.3582816076428;1368.363710874448;1431.6063082652354;1456.3155317000992;23451.296461106194;31462.28600176351;32207.516887246242;32349.676503234667;32626.184345391554;55346.72326638341;56004.43995560155;56141.719291404916;56151.43848561462;56289.15566266427;622718;627730;627976;628024;628613;29720.851395742884;36595.634043660284;37076.07309817276;38737.225255494166;42836.571634284504;43413.348799767395;45644.77177614091;45669.771651141535;46076.078478429576;46581;31582.842085789423;37938.62061379351;38457;38572.421413678254;38839.80580097081;37701.81149094237;37912;37961.81019094887;39238;39542.2091558173;31275.218119547193;36781.816090919376;37069;37598.81200594089;37763.43354849624;32914;33740.66259337375;34430.311393772485;34494.310113798085;34593.65406346005;25164.370890727147;25182.74817251804;25322.366940826625;25502.362440939123;25857 09:40:04 INFO - PROCESS | 1639 | |2;jquery.html;335.73476953206966;385.3352966133418;395.3180763183508;408.8078603056566;414.56470705758943;19400.90299548502;21537.138514459402;21594.89202553987;21808.345749627497;21826.363022773297;20245;20361;20953.37139885802;21168.89415552924;21447;4866.805327786902;6001;6168.47567956722;6229.37706229378;6241.4694750946;4427.468703755554;4671.813127474897;4678.064387122572;6642.136522252124;6934.375906168469;6620.205575330943;6781.321867813229;6948.409385202264;6957.930420695779;6982.441404687613;6837.418819400357;6886.862262754767;6889.138857642794;6892.965535172342;6903.206131294915;5760.53915686744;5977.521798256129;6043.848903777397;6054.182685337467;6071.483923866476;25995.61006584903;26272.73727262741;26276;26328.73671263301;26396.340091497674;2291;2378.5242951409787;2414.625733011386;2432.063655492648;3063.7242648161773;16804.495865124067;17500.374943758412;17671.646567068714;18540.62918741631;18636.813631863643;1780.6794776940146;2004.979950200494;2029.2694629933212;2069.865458745192;2191.9259562814264;105819;146465;150761;151207;156083;17821.910890445724;21924.89037554802;22272.65910113496;22338.65444128343;22507.598176437536;36629.26741465209;37066.07334816597;37453;37495.43756843649;37544.87365379043;10919.945400272947;11084.501197446134;11296.152788540892;11326.886731132749;11567.132465065153;9166.724998250063;9213.723588292361;9214.44713317203;9341.486218258062;9352.672656457127;9886.4562449066;9983.650572230083;10039.385821104397;10076.848847267296;10162.934826069632;3070.6008218931397;3782.6973842092566;3802.448644946467;3821.980635298083;3926.1166237596885;806.8023334283021;881.6825942660637;894.615315414365;963.1476143612953;1082.3830416662584;20470.488237794176;21396.679049814265;21404;21404.03681834321;21458.89270553637;924.5700749151677;962.7785609309758;967.2213867836318;978.6085565773606;984.5766320482261;10481.213908956706;11143.164262680331;11183.608573700045;11189.608363707232;11195.936386043475;609447;610008;611264;624242;624428;125632;129894;130299;131039.34480327538;132268.67731322756;978.3738407419257;983.2920297385871;992.5880759484877;995.8705368302075;996.9700908972742;17251.326044463127;18126.27494900189;18778.624427511648;18779.436616901516;18781.81218187855;54011.729941350044;55505.88988220132;55599.16601251066;55754.72122639361;56406.1539076906;70736.64631676809;76443.61778191074;78179.21820781947;82279.35441291261;82910;7323.890141647773;8099.919000809917;8111.918880811117;8316.168383161636;8492.065872754116;9809.215262779104;9903.801923961624;12306.569270075504;12507.187032842836;12623.81064284018;11012.229143959847;11064.170187235828;11074.723131921766;11102.555897764;11477.483513241757;9803.509824508888;10082.495875206358;11141.665750027512;11179.944100279447;11523.193376463567;10000.849987250052;11195.320701894781;11205.879412058728;11244.775104498029;11539.307641541534;8165.061017983008;8183.140770219041;8466.153384661484;8507.532085735096;8539.914600854161;10346.172306215636;10766.461676915966;10967.396793176453;11208.831867522156;11332.660020199408 09:40:04 INFO - PROCESS | 1639 | |3;mootools.html;1505.1495904813783;1533.4096372896433;1689.8732595055367;1845.2157832921005;1847.61200147969;7945.761627151188;8390.832183356337;8435.409521333493;8440.831183376336;8456;7494.175640679521;7673.539587624747;7993;8189.262966333029;8265.338772898169;2366.2901129661077;2400.1599440195964;2400.867952262625;2405.927822165338;2409.0484258717797;2405.170216275391;2418.4921166555046;2459.4712136890566;2460.938476538083;2461.938451538708;2391.7488663690324;2394.1500767227644;2412.589859723851;2419.9637005444933;2433.7322894481595;2379.8334116611845;2383.9046438142454;2407.735149133594;2409.903603855844;2416.6495858100475;2410.68661074061;2417.0573476344066;2433.85396876188;2434.6591477193206;2436.9512609747885;8326.583670816495;8367.037790654093;8436.789080273042;8440.113788052227;8441.662333506652;5117;5275.155975043975;5277.86805329866;5282.656627319212;5284.762185701614;3184.092533627928;3500.789952602852;3509.771864828778;3515.54297941266;3591.712662986955;1003.7440452684592;1022.4734261855151;1033.8604288421043;1079.13129930406;1079.983800242997;10258.17934565233;10345.741356466073;10347.896521034769;10356.016178463035;10379.3253438527;4480.395146655225;4525.04973955473;4609.331646911179;4614.792334344896;4787.42550893895;7535.246475352531;9432.858507122399;9439.858402123973;9457.810843783085;9470.715878523655;5260.342457192851;5261.131913234273;5263.447338029452;5263.921041184385;5273.31446911899;4378.540253273361;4502;4709.8351557696005;4780.4741478437345;4842.249451335048;3826.4069069294305;3856.9228615427533;3915.7258991870867;3961.7028722845903;3962.782046987386;1278.3544310123327;1289.9032572557096;1293.1077556485996;1300.0509627971444;1303.6219496346143;914.8627705844177;917.4449458077901;918.2332752152028;927.7495076329488;958.2621381536178;5615.185798059259;5747.942520574741;5880.588358814842;5957.285125784933;6087.543434242361;915.4461550761827;944.187998321443;952.8570714392758;954.9570269337896;970.6748239339901;3739.476473293741;3854.730168888207;3863.285292220948;3934.409838524244;4012.4181993610764;9709.320347575744;10148.949255253676;10179.440130792878;10216.540255688511;10293;8833.734987950373;9049.095090490899;9288.374534456443;10141.29010969225;10148.238882083873;7666.65500052499;7880.960595196987;7895.210478952174;7902.525848449226;7935.127136015034;5661.405552417102;5691.4877661010705;5724.713764311685;5856.707164641836;5908.379620139824;7776.416768742254;9137.360384773268;9270.582823772811;9467.2426205902;9525.476098814632;9193.448393096436;9446.433214007182;9573.760655983377;9573.899001614625;9575;5873.4126587342635;6673.366030227121;6872.41584465306;7078.504504684623;7217.6752046157;7872.252136047066;7890.605469726605;8007.759767206993;8012.078610959814;8020.558869262247;7067.893981590383;7214.71141154348;7228.31331023552;7240.96379518099;7337.3763230123905;6993.125859267591;7063.364297213276;7070.68181931804;7185.958036084843;7209.675564599501;6666.400023997863;6683.264840867403;6734.629595372302;6750.493712971645;6753;4879.268109783561;4910.803567857246;4911.140550403594;4922.089413458521;4946.554810067111;4857.101436234308;4864.173090574682;4889.731064791471;4935.506449355179;5069.99735104639 09:40:04 INFO - PROCESS | 1639 | |4;prototype.html;295.4829049163963;300.5671832561112;308.70981277599054;313.03116853338906;315.0187166974874;4692.859214223575;5092.772998411309;5267.762950667219;5270.522854258497;5273.5781137509;4328.545502722216;4561.947123794289;4733.266343716721;5195.532402083812;5232.555232805206;3272.132884785534;3459.342724882277;3984.6413822755944;4000.3599424092004;4017.658499027586;3992.2414741199223;4001.5798341174195;4011.65900898424;4012.919741605166;4025.919481610366;3667.413213885779;3933.213357328546;3973.582773808752;3991.521017477892;4004.9186719585696;3921.686265098785;3951.8616848410456;3967.305721498726;3971.682265418774;3999.1601763629674;3387.4749413840896;3397.8640854365794;3404.676555727202;3406.5230867678547;3425.5546778918583;4607.907841843178;4669.32294817253;5100;5127.564157046618;5169.483051694838;3731.8693845715543;4415.536368681274;4496.9325460118125;4506.639468842484;4506.639468842484;4759.738214398207;5453.773325672596;5497.45025497451;5497.670139791625;5503.752331145108;3749.4750734897134;3755.267722794056;3758.868439604628;3774.1885494618787;3789.4315852622326;4960.702357858504;5481.917771233435;5531.502164805147;5692.800751973702;5782.306123265193;3406.9659303407143;3439.81326442382;3691.630836916287;3696.5194524711615;3705.7591256568776;3752.3433399155037;3873.903152421212;3891.3579259422445;3895.902602434905;3912.256671232514;4202.831886724558;4440.3339499074755;4500.302453119772;4507.498338422141;4510.36854840316;4855.757212139379;5109.463506331856;5337.893242135136;5550.750216240279;5593.692346920877;1108.7449886526144;1232.9445174967148;1240.7394447166016;1262.7183408840035;1287.1440492072854;742.8040854224694;836.3560058754846;848.5587494502947;857.562643052048;867.3234876796109;4724.00795832879;4726.71639701619;4961.70229786214;4968.931679688884;4971.502849715;5283.841484755463;5307.601929855199;5323.604378029902;5376.973115134399;5403.487023633389;3807.371783655721;3912.691512007929;4387.670924680661;4441.933370999438;4724.842413608688;2430.6840110785483;2815.3389500194985;2822.50606143924;2838.815476993989;2844.6728626207837;4750.857474275777;4829.251466022772;4860.535487801216;4972.577330926912;5605.495505404451;5237.266782650432;5500.7524661390335;5519.013155264101;5519.282493275929;5525.502704756591;4550.565447485579;4782.019685964438;5422.620416570802;5550.91673624896;5576.657803722446;4936.136176169084;5233.424323324355;5337.930689853272;5362.65142765719;5412.377576578744;4573.725576465423;4737.786799594095;5219.269302297757;5303.851939964321;5696.515796157373;5712.971435142797;5850.888331217056;6017.398260173947;6032.698365081641;6044.818655440344;3713.9257214856093;3727.1800203955086;3787.242551489658;3818.312703713358;3845.5000849889334;4652.348671185969;5139.815578379099;5256.4743525648655;5570.359408668055;5758.222639943554;5444.401115877171;5523.9894257628885;5555.72221388937;5579.218909352613;5623.297087864017;4749.860033591844;5277.2875661785165;5523.613347065828;5548.334199896039;5564.554835613222;5410.891782164256;5432.538234250133;5435.972820135874;5437;5511;5255.9211611825085;5489.945100548944;5511.669299842022;5534.944650553443;5558.832645144565;5422.8373148805595;5426.8371948841595;5428.240046393587;5442.374126975448;5448.427915069019 09:40:04 INFO - PROCESS | 1639 | |5;yui.html;697.8953157026446;760.8744557148071;779.7465823607328;811.7686459359084;845.8604330285503;14685.853141468582;15467.845321546782;15543.300551475182;15609.921950390246;15638.687226255468;13939.233342166202;14090.436382544685;14093.224872632027;14112.082714623568;14121.43514259431;685.3352248319147;704.1128178495107;707.0560801330205;827.9958600206991;859.0593300336153;837.9832403351929;856.5160684213399;858.3648100405686;858.4076986879064;858.4849090545654;903.7966457547066;908.8954770201412;909.6816114359988;909.6816114359988;909.8316811389881;904.6607522179182;904.8371293167228;905.3300557587404;905.9365844390895;906.4289497616526;668.7091115364832;672.0993868216565;672.6031641331638;672.8721542906832;672.9259781424039;14523.782143267754;14729.631759206106;14760.852391476055;14771.409143634242;15071.191457025117;14200.431982720678;14614.415423383158;14628.195449250286;14814;14856.480023199136;10803.621873234399;11344.376059316734;11379.943100284529;11756.764864702744;11760.470778814888;4584.701994370355;4643.2802915548145;4711.199096153662;4792.616590672737;4808.855734327941;93239.13521729528;93556.06443935541;94460;95776.52111739466;95810;10388.324758890649;10705.678829635124;10760.085392741548;10884.945575272073;10963.574735284363;19260.614787704446;19576;19675.01624918777;19845.900770496057;19855.503612409517;7902.644381002754;8064.395170362129;8067.273945344947;8079.434439589172;8136.511809291462;4502.347159661831;4504.166729155117;4581.587657110809;4588.7935042923145;4692.741899195509;2860.3993161436333;3488.7383446241633;3508.5088087667746;3512.929741405209;3520.190356218084;668.866226754651;676.7529851604129;677.8949262864264;686.1012074182836;687.6630451078935;567.1266249975075;580.080572292912;617.413457215638;690.975815846443;698.7309885694044;8829;9235.722928312027;9264.72205833826;9396.765080873032;9468.28987825902;648.8896887529131;659.4328877165634;676.7834293026184;710.4919982212639;719.8380364417964;4035.616616421435;4289;4551.658625603093;4555.908881822345;4584.426946631671;69185.65407172932;94290.11419771567;105353;106887;113406.86593134128;63640.363596363444;65268;81322.59338703268;99791;100623.99376006146;91680.6247906282;93104.3750933251;93238.0676193243;93953.06046939443;96101.31189504823;8535.402521823413;8846.911530884867;8972.955135224543;9058.139476749699;9698.124311141899;39035.21929561449;39919.401208981304;48402;50496.747516262185;52405.23542410255;70266;73127.26872731204;75615;77756.61121694355;78531.21468785239;12568.937155314165;12805.103642744918;12923.547675831302;13062.54281100157;13220.933895330461;13437.798433023709;13776.724465510833;14142.717145657234;14440.927795360956;14490.275486225435;13167.078304518593;13261.53584624572;14173.291335433394;14419.927900360432;14785.704285914006;12853.357332133543;13830.65423364424;14153.221572813594;14783.260836957894;14815.25923703832;11451.942740286246;14016.78974815399;14075.296235188405;14355.497557585435;14371.353289101806;9813.264005199495;11115.333080015225;11578.536858525564;11793.882061179278;11944.462499187384;9582.520873956135;10091.596336146471;11092.445377730919;11444.542218311175;11459.942700286445 09:40:04 INFO - PROCESS | 1639 | __end_tp_report 09:40:04 INFO - PROCESS | 1639 | __start_cc_report 09:40:04 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1791 09:40:04 INFO - PROCESS | 1639 | __end_cc_report 09:40:04 INFO - PROCESS | 1639 | __startTimestamp1485366003999__endTimestamp 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | ------- Summary: start ------- 09:40:04 INFO - PROCESS | 1639 | Number of tests: 6 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5807.29 Median:6089.73 stddev:655.51 (10.8%) stddev-sans-first:631.04 09:40:04 INFO - PROCESS | 1639 | Values: 3455.8 3456.3 3474.6 3481.4 3529.4 5782.0 5802.2 5803.9 5806.3 5858.2 5762.7 5825.4 5828.0 5829.7 5829.9 5211.6 5220.3 5251.5 5288.9 5329.2 4271.9 4493.3 5187.8 5204.8 5231.5 5229.9 5252.0 5278.5 5297.9 5301.3 5248.4 5274.8 5335.8 5336.8 5348.8 5144.5 5216.8 5279.9 5290.9 5313.4 5672.6 5699.1 5703.3 5716.9 5797.1 6203.1 6243.6 6335.4 6338.1 6345.1 6225.7 6327.4 6388.4 6392.0 6392.6 5767.8 5840.9 5883.5 5947.0 5955.0 6319.6 6330.9 6340.8 6341.5 6374.2 6093.7 6265.6 6273.7 6295.4 6298.6 6248.6 6258.7 6304.3 6318.5 6323.6 6212.2 6238.6 6284.8 6368.7 6377.8 6297.2 6345.7 6356.6 6358.9 6379.6 4914.6 4949.9 5020.3 5034.2 5054.8 4463.6 4482.1 4505.1 4523.8 4526.0 5895.8 5914.1 5931.3 5935.0 5970.7 6198.6 6345.1 6353.6 6385.1 6403.1 5687.3 5769.5 5820.3 5877.8 5917.5 5486.9 5490.4 5502.9 5512.9 5532.6 5346.8 6381.2 6397.0 6407.6 6412.4 6218.3 6219.1 6239.1 6269.8 6375.6 6288.3 6321.2 6331.9 6357.0 6370.6 6290.9 6319.5 6323.7 6328.7 6335.3 5813.5 6145.3 6258.0 6360.7 6380.2 6106.9 6121.9 6153.8 6239.3 6252.2 6017.0 6209.0 6238.6 6239.0 6240.3 5904.0 6006.3 6020.9 6089.7 6090.7 5067.9 6115.0 6124.7 6136.1 6241.4 6090.4 6098.2 6103.1 6117.7 6132.5 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:74928.72 Median:39264.30 stddev:171902.32 (437.8%) stddev-sans-first:172293.70 09:40:04 INFO - PROCESS | 1639 | Values: 490.9 520.1 543.7 550.0 554.3 33455.2 35753.6 38933.8 40070.6 40367.4 39431.2 41941.7 42306.6 42436.8 42549.8 9628.5 9823.1 9826.7 9827.8 9829.0 9639.2 9765.3 9770.9 9774.4 9782.2 9777.0 9826.8 9827.3 9827.8 9858.1 9722.0 9782.0 9788.8 9789.0 9791.3 9639.5 9722.6 9723.5 9724.6 9735.0 39290.6 39660.0 39672.6 39685.0 39705.8 3550.3 3592.1 3618.9 3983.5 4141.0 29369.0 29860.4 30226.7 30235.0 31175.8 3191.7 3198.3 3297.3 3299.8 3348.3 512398.0 513332.4 513470.0 514346.0 515692.0 55852.0 56037.6 56135.7 56251.0 56291.7 34659.8 35515.8 35550.1 36338.3 36397.5 15633.6 15749.8 15760.6 15769.2 15776.6 12698.8 12810.0 12811.3 12819.3 12832.7 18194.3 18410.8 18451.0 18558.4 18711.6 6746.5 7805.2 7815.8 7873.3 7884.0 880.3 975.0 982.4 1062.2 1100.0 27047.3 28614.7 29111.0 29442.9 29748.9 1040.7 1071.8 1094.4 1098.5 1107.1 14400.7 14831.8 14913.9 15057.1 15463.8 690141.0 762720.0 775447.0 775933.0 777394.0 58855.4 59562.7 59702.7 63461.7 63489.7 1325.4 1365.4 1368.4 1431.6 1456.3 23451.3 31462.3 32207.5 32349.7 32626.2 55346.7 56004.4 56141.7 56151.4 56289.2 622718.0 627730.0 627976.0 628024.0 628613.0 29720.9 36595.6 37076.1 38737.2 42836.6 43413.3 45644.8 45669.8 46076.1 46581.0 31582.8 37938.6 38457.0 38572.4 38839.8 37701.8 37912.0 37961.8 39238.0 39542.2 31275.2 36781.8 37069.0 37598.8 37763.4 32914.0 33740.7 34430.3 34494.3 34593.7 25164.4 25182.7 25322.4 25502.4 25857.0 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:37820.39 Median:3067.16 stddev:103077.33 (3360.7%) stddev-sans-first:103328.07 09:40:04 INFO - PROCESS | 1639 | Values: 335.7 385.3 395.3 408.8 414.6 19400.9 21537.1 21594.9 21808.3 21826.4 20245.0 20361.0 20953.4 21168.9 21447.0 4866.8 6001.0 6168.5 6229.4 6241.5 4427.5 4671.8 4678.1 6642.1 6934.4 6620.2 6781.3 6948.4 6957.9 6982.4 6837.4 6886.9 6889.1 6893.0 6903.2 5760.5 5977.5 6043.8 6054.2 6071.5 25995.6 26272.7 26276.0 26328.7 26396.3 2291.0 2378.5 2414.6 2432.1 3063.7 16804.5 17500.4 17671.6 18540.6 18636.8 1780.7 2005.0 2029.3 2069.9 2191.9 105819.0 146465.0 150761.0 151207.0 156083.0 17821.9 21924.9 22272.7 22338.7 22507.6 36629.3 37066.1 37453.0 37495.4 37544.9 10919.9 11084.5 11296.2 11326.9 11567.1 9166.7 9213.7 9214.4 9341.5 9352.7 9886.5 9983.7 10039.4 10076.8 10162.9 3070.6 3782.7 3802.4 3822.0 3926.1 806.8 881.7 894.6 963.1 1082.4 20470.5 21396.7 21404.0 21404.0 21458.9 924.6 962.8 967.2 978.6 984.6 10481.2 11143.2 11183.6 11189.6 11195.9 609447.0 610008.0 611264.0 624242.0 624428.0 125632.0 129894.0 130299.0 131039.3 132268.7 978.4 983.3 992.6 995.9 997.0 17251.3 18126.3 18778.6 18779.4 18781.8 54011.7 55505.9 55599.2 55754.7 56406.2 70736.6 76443.6 78179.2 82279.4 82910.0 7323.9 8099.9 8111.9 8316.2 8492.1 9809.2 9903.8 12306.6 12507.2 12623.8 11012.2 11064.2 11074.7 11102.6 11477.5 9803.5 10082.5 11141.7 11179.9 11523.2 10000.8 11195.3 11205.9 11244.8 11539.3 8165.1 8183.1 8466.2 8507.5 8539.9 10346.2 10766.5 10967.4 11208.8 11332.7 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5450.31 Median:5268.62 stddev:2890.39 (54.9%) stddev-sans-first:2883.29 09:40:04 INFO - PROCESS | 1639 | Values: 1505.1 1533.4 1689.9 1845.2 1847.6 7945.8 8390.8 8435.4 8440.8 8456.0 7494.2 7673.5 7993.0 8189.3 8265.3 2366.3 2400.2 2400.9 2405.9 2409.0 2405.2 2418.5 2459.5 2460.9 2461.9 2391.7 2394.2 2412.6 2420.0 2433.7 2379.8 2383.9 2407.7 2409.9 2416.6 2410.7 2417.1 2433.9 2434.7 2437.0 8326.6 8367.0 8436.8 8440.1 8441.7 5117.0 5275.2 5277.9 5282.7 5284.8 3184.1 3500.8 3509.8 3515.5 3591.7 1003.7 1022.5 1033.9 1079.1 1080.0 10258.2 10345.7 10347.9 10356.0 10379.3 4480.4 4525.0 4609.3 4614.8 4787.4 7535.2 9432.9 9439.9 9457.8 9470.7 5260.3 5261.1 5263.4 5263.9 5273.3 4378.5 4502.0 4709.8 4780.5 4842.2 3826.4 3856.9 3915.7 3961.7 3962.8 1278.4 1289.9 1293.1 1300.1 1303.6 914.9 917.4 918.2 927.7 958.3 5615.2 5747.9 5880.6 5957.3 6087.5 915.4 944.2 952.9 955.0 970.7 3739.5 3854.7 3863.3 3934.4 4012.4 9709.3 10148.9 10179.4 10216.5 10293.0 8833.7 9049.1 9288.4 10141.3 10148.2 7666.7 7881.0 7895.2 7902.5 7935.1 5661.4 5691.5 5724.7 5856.7 5908.4 7776.4 9137.4 9270.6 9467.2 9525.5 9193.4 9446.4 9573.8 9573.9 9575.0 5873.4 6673.4 6872.4 7078.5 7217.7 7872.3 7890.6 8007.8 8012.1 8020.6 7067.9 7214.7 7228.3 7241.0 7337.4 6993.1 7063.4 7070.7 7186.0 7209.7 6666.4 6683.3 6734.6 6750.5 6753.0 4879.3 4910.8 4911.1 4922.1 4946.6 4857.1 4864.2 4889.7 4935.5 5070.0 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4383.35 Median:4805.64 stddev:1342.85 (27.9%) stddev-sans-first:1311.10 09:40:04 INFO - PROCESS | 1639 | Values: 295.5 300.6 308.7 313.0 315.0 4692.9 5092.8 5267.8 5270.5 5273.6 4328.5 4561.9 4733.3 5195.5 5232.6 3272.1 3459.3 3984.6 4000.4 4017.7 3992.2 4001.6 4011.7 4012.9 4025.9 3667.4 3933.2 3973.6 3991.5 4004.9 3921.7 3951.9 3967.3 3971.7 3999.2 3387.5 3397.9 3404.7 3406.5 3425.6 4607.9 4669.3 5100.0 5127.6 5169.5 3731.9 4415.5 4496.9 4506.6 4506.6 4759.7 5453.8 5497.5 5497.7 5503.8 3749.5 3755.3 3758.9 3774.2 3789.4 4960.7 5481.9 5531.5 5692.8 5782.3 3407.0 3439.8 3691.6 3696.5 3705.8 3752.3 3873.9 3891.4 3895.9 3912.3 4202.8 4440.3 4500.3 4507.5 4510.4 4855.8 5109.5 5337.9 5550.8 5593.7 1108.7 1232.9 1240.7 1262.7 1287.1 742.8 836.4 848.6 857.6 867.3 4724.0 4726.7 4961.7 4968.9 4971.5 5283.8 5307.6 5323.6 5377.0 5403.5 3807.4 3912.7 4387.7 4441.9 4724.8 2430.7 2815.3 2822.5 2838.8 2844.7 4750.9 4829.3 4860.5 4972.6 5605.5 5237.3 5500.8 5519.0 5519.3 5525.5 4550.6 4782.0 5422.6 5550.9 5576.7 4936.1 5233.4 5337.9 5362.7 5412.4 4573.7 4737.8 5219.3 5303.9 5696.5 5713.0 5850.9 6017.4 6032.7 6044.8 3713.9 3727.2 3787.2 3818.3 3845.5 4652.3 5139.8 5256.5 5570.4 5758.2 5444.4 5524.0 5555.7 5579.2 5623.3 4749.9 5277.3 5523.6 5548.3 5564.6 5410.9 5432.5 5436.0 5437.0 5511.0 5255.9 5489.9 5511.7 5534.9 5558.8 5422.8 5426.8 5428.2 5442.4 5448.4 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20299.97 Median:4701.97 stddev:29179.98 (620.6%) stddev-sans-first:29224.72 09:40:04 INFO - PROCESS | 1639 | Values: 697.9 760.9 779.7 811.8 845.9 14685.9 15467.8 15543.3 15609.9 15638.7 13939.2 14090.4 14093.2 14112.1 14121.4 685.3 704.1 707.1 828.0 859.1 838.0 856.5 858.4 858.4 858.5 903.8 908.9 909.7 909.7 909.8 904.7 904.8 905.3 905.9 906.4 668.7 672.1 672.6 672.9 672.9 14523.8 14729.6 14760.9 14771.4 15071.2 14200.4 14614.4 14628.2 14814.0 14856.5 10803.6 11344.4 11379.9 11756.8 11760.5 4584.7 4643.3 4711.2 4792.6 4808.9 93239.1 93556.1 94460.0 95776.5 95810.0 10388.3 10705.7 10760.1 10884.9 10963.6 19260.6 19576.0 19675.0 19845.9 19855.5 7902.6 8064.4 8067.3 8079.4 8136.5 4502.3 4504.2 4581.6 4588.8 4692.7 2860.4 3488.7 3508.5 3512.9 3520.2 668.9 676.8 677.9 686.1 687.7 567.1 580.1 617.4 691.0 698.7 8829.0 9235.7 9264.7 9396.8 9468.3 648.9 659.4 676.8 710.5 719.8 4035.6 4289.0 4551.7 4555.9 4584.4 69185.7 94290.1 105353.0 106887.0 113406.9 63640.4 65268.0 81322.6 99791.0 100624.0 91680.6 93104.4 93238.1 93953.1 96101.3 8535.4 8846.9 8973.0 9058.1 9698.1 39035.2 39919.4 48402.0 50496.7 52405.2 70266.0 73127.3 75615.0 77756.6 78531.2 12568.9 12805.1 12923.5 13062.5 13220.9 13437.8 13776.7 14142.7 14440.9 14490.3 13167.1 13261.5 14173.3 14419.9 14785.7 12853.4 13830.7 14153.2 14783.3 14815.3 11451.9 14016.8 14075.3 14355.5 14371.4 9813.3 11115.3 11578.5 11793.9 11944.5 9582.5 10091.6 11092.4 11444.5 11459.9 09:40:04 INFO - PROCESS | 1639 | -------- Summary: end -------- 09:40:04 INFO - PROCESS | 1639 | 09:40:04 INFO - TEST-INFO | 1639: exit 0 09:40:04 INFO - TEST-OK | dromaeo_css | took 1118075ms 09:40:04 INFO - TEST-START | kraken 09:40:04 INFO - operating with platform_type : mac_ 09:40:04 INFO - Initialising browser for kraken test... 09:40:04 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpcblrGn/profile http://localhost:49248/getInfo.html) 09:40:06 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:40:06 INFO - PROCESS | 1649 | colorDepth:24 09:40:06 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:40:06 INFO - PROCESS | 1649 | __metrics 09:40:06 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:40:06 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:07 INFO - TEST-INFO | 1649: exit 0 09:40:07 INFO - Browser initialized. 09:40:07 INFO - Running cycle 1/1 for kraken test... 09:40:07 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/tmpcblrGn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:19 INFO - PROCESS | 1651 | RSS: Main: 167657472 09:40:19 INFO - PROCESS | 1651 | 09:40:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:23 INFO - PROCESS | 1651 | RSS: Main: 218476544 09:40:23 INFO - PROCESS | 1651 | 09:40:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 09:40:26 INFO - PROCESS | 1651 | RSS: Main: 233537536 09:40:26 INFO - PROCESS | 1651 | 09:40:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 09:40:30 INFO - PROCESS | 1651 | RSS: Main: 329031680 09:40:30 INFO - PROCESS | 1651 | 09:40:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 09:40:33 INFO - PROCESS | 1651 | RSS: Main: 230866944 09:40:33 INFO - PROCESS | 1651 | 09:40:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:35 INFO - PROCESS | 1651 | RSS: Main: 233279488 09:40:35 INFO - PROCESS | 1651 | 09:40:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:39 INFO - PROCESS | 1651 | RSS: Main: 274538496 09:40:39 INFO - PROCESS | 1651 | 09:40:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:42 INFO - PROCESS | 1651 | RSS: Main: 271474688 09:40:42 INFO - PROCESS | 1651 | 09:40:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 09:40:46 INFO - PROCESS | 1651 | RSS: Main: 268668928 09:40:46 INFO - PROCESS | 1651 | 09:40:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:48 INFO - PROCESS | 1651 | RSS: Main: 248762368 09:40:48 INFO - PROCESS | 1651 | 09:40:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:51 INFO - PROCESS | 1651 | RSS: Main: 247394304 09:40:51 INFO - PROCESS | 1651 | 09:40:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:53 INFO - PROCESS | 1651 | RSS: Main: 251183104 09:40:53 INFO - PROCESS | 1651 | 09:40:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:57 INFO - PROCESS | 1651 | RSS: Main: 270307328 09:40:57 INFO - PROCESS | 1651 | 09:41:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:00 INFO - PROCESS | 1651 | RSS: Main: 264028160 09:41:00 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 09:41:02 INFO - PROCESS | 1651 | RSS: Main: 308465664 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | __start_tp_report 09:41:02 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 09:41:02 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 09:41:02 INFO - PROCESS | 1651 | |i|pagename|runs| 09:41:02 INFO - PROCESS | 1651 | |0;ai-astar;104;115;114;114;111;114;114;117;158;165 09:41:02 INFO - PROCESS | 1651 | |1;audio-beat-detection;141;108;106;140;108;108;110;131;172;105 09:41:02 INFO - PROCESS | 1651 | |2;audio-dft;181;183;183;181;184;182;182;183;183;184 09:41:02 INFO - PROCESS | 1651 | |3;audio-fft;80;59;59;87;60;59;74;82;109;64 09:41:02 INFO - PROCESS | 1651 | |4;audio-oscillator;85;70;92;82;96;100;113;69;68;90 09:41:02 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;86;88;130;135;97;91;91;94;88 09:41:02 INFO - PROCESS | 1651 | |6;imaging-darkroom;96;95;95;96;108;150;148;116;94;94 09:41:02 INFO - PROCESS | 1651 | |7;imaging-desaturate;80;85;79;83;82;86;129;91;84;81 09:41:02 INFO - PROCESS | 1651 | |8;json-parse-financial;57;53;52;54;57;56;57;53;55;76 09:41:02 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;63;71;70;74;71;67;68;68;67;68 09:41:02 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;78;83;82;82;81;81;82;84;81;83 09:41:02 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;137;136;136;113;145;149;155;157;183;148 09:41:02 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;162;162;161;163;162;166;160;160;162;162 09:41:02 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;65;65;65;65;65 09:41:02 INFO - PROCESS | 1651 | __end_tp_report 09:41:02 INFO - PROCESS | 1651 | __start_cc_report 09:41:02 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1865 09:41:02 INFO - PROCESS | 1651 | __end_cc_report 09:41:02 INFO - PROCESS | 1651 | __startTimestamp1485366062617__endTimestamp 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | ------- Summary: start ------- 09:41:02 INFO - PROCESS | 1651 | Number of tests: 14 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:122.60 Median:114.50 stddev:20.86 (18.2%) stddev-sans-first:21.01 09:41:02 INFO - PROCESS | 1651 | Values: 104.0 115.0 114.0 114.0 111.0 114.0 114.0 117.0 158.0 165.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:120.50 stddev:22.45 (18.6%) stddev-sans-first:22.83 09:41:02 INFO - PROCESS | 1651 | Values: 141.0 108.0 106.0 140.0 108.0 108.0 110.0 131.0 172.0 105.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.07 (0.6%) stddev-sans-first:0.97 09:41:02 INFO - PROCESS | 1651 | Values: 181.0 183.0 183.0 181.0 184.0 182.0 182.0 183.0 183.0 184.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:73.30 Median:69.00 stddev:16.53 (24.0%) stddev-sans-first:17.36 09:41:02 INFO - PROCESS | 1651 | Values: 80.0 59.0 59.0 87.0 60.0 59.0 74.0 82.0 109.0 64.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:83.50 stddev:14.76 (17.7%) stddev-sans-first:15.64 09:41:02 INFO - PROCESS | 1651 | Values: 85.0 70.0 92.0 82.0 96.0 100.0 113.0 69.0 68.0 90.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:98.90 Median:90.00 stddev:18.03 (20.0%) stddev-sans-first:18.76 09:41:02 INFO - PROCESS | 1651 | Values: 89.0 86.0 88.0 130.0 135.0 97.0 91.0 91.0 94.0 88.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:94.50 stddev:22.19 (23.5%) stddev-sans-first:23.02 09:41:02 INFO - PROCESS | 1651 | Values: 96.0 95.0 95.0 96.0 108.0 150.0 148.0 116.0 94.0 94.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:88.00 Median:83.50 stddev:14.81 (17.7%) stddev-sans-first:15.42 09:41:02 INFO - PROCESS | 1651 | Values: 80.0 85.0 79.0 83.0 82.0 86.0 129.0 91.0 84.0 81.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:6.93 (12.3%) stddev-sans-first:7.35 09:41:02 INFO - PROCESS | 1651 | Values: 57.0 53.0 52.0 54.0 57.0 56.0 57.0 53.0 55.0 76.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:2.98 (4.3%) stddev-sans-first:2.35 09:41:02 INFO - PROCESS | 1651 | Values: 63.0 71.0 70.0 74.0 71.0 67.0 68.0 68.0 67.0 68.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.64 (2.0%) stddev-sans-first:1.05 09:41:02 INFO - PROCESS | 1651 | Values: 78.0 83.0 82.0 82.0 81.0 81.0 82.0 84.0 81.0 83.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:148.50 stddev:18.12 (12.2%) stddev-sans-first:18.93 09:41:02 INFO - PROCESS | 1651 | Values: 137.0 136.0 136.0 113.0 145.0 149.0 155.0 157.0 183.0 148.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:1.70 (1.0%) stddev-sans-first:1.80 09:41:02 INFO - PROCESS | 1651 | Values: 162.0 162.0 161.0 163.0 162.0 166.0 160.0 160.0 162.0 162.0 09:41:02 INFO - PROCESS | 1651 | 09:41:02 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 09:41:02 INFO - PROCESS | 1651 | Values: 66.0 66.0 67.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 09:41:02 INFO - PROCESS | 1651 | -------- Summary: end -------- 09:41:02 INFO - PROCESS | 1651 | 09:41:03 INFO - TEST-INFO | 1651: exit 0 09:41:03 INFO - TEST-OK | kraken | took 59072ms 09:41:03 INFO - SUITE-END | took 1177s 09:41:03 INFO - Completed test suite (00:19:37) 09:41:03 INFO - javascript benchmark 09:41:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.792652440852, 3456.2569047654756, 3474.6351633078534, 3481.3907566175913, 3529.4352903535423, 5781.959247335478, 5802.245708057957, 5803.854903627406, 5806.332271788746, 5858.150568167618, 5762.683052432115, 5825.417458254173, 5827.970860145704, 5829.650220986744, 5829.8834023319505, 5211.609129315307, 5220.347456567929, 5251.501107394811, 5288.867778305535, 5329.227262047001, 4271.8718438446895, 4493.3484644726495, 5187.792488300463, 5204.843854684365, 5231.450697676727, 5229.869253268661, 5252.0, 5278.498542638443, 5297.947020529803, 5301.3373328333955, 5248.448912864133, 5274.841754747364, 5335.8132465363915, 5336.786528538853, 5348.759305831247, 5144.485551444863, 5216.843494695166, 5279.947200527984, 5290.947090529084, 5313.388960269541, 5672.574556908207, 5699.088145896637, 5703.287089113861, 5716.885662286731, 5797.130430435426, 6203.069539569055, 6243.594166379171, 6335.429811317003, 6338.080978258126, 6345.079963405326, 6225.688715564249, 6327.367263273636, 6388.39310265524, 6392.041193820917, 6392.616443013434, 5767.798127065533, 5840.88318233633, 5883.499902508249, 5946.970265148647, 5955.0, 6319.593427543223, 6330.936690633035, 6340.841478963062, 6341.524385671093, 6374.203224596926, 6093.725782339805, 6265.624062556261, 6273.7176827042895, 6295.401936815995, 6298.622082675054, 6248.593841400295, 6258.655773932477, 6304.338044505353, 6318.494520438354, 6323.620582765049, 6212.223472065992, 6238.594491358138, 6284.811455656338, 6368.713407896563, 6377.7767778127545, 6297.1813664223355, 6345.714442850082, 6356.586821856565, 6358.904616430757, 6379.64911929839, 4914.557689807934, 4949.851504454872, 5020.347354843847, 5034.244863270539, 5054.848354549369, 4463.598276155161, 4482.058767658763, 4505.144022635689, 4523.796429160696, 4526.0, 5895.823125306248, 5914.142449344821, 5931.347551769302, 5935.020721580977, 5970.731317090741, 6198.566100372931, 6345.143405640272, 6353.5870168438905, 6385.138006369174, 6403.103565500834, 5687.289088863892, 5769.480746732815, 5820.30156381237, 5877.823665290048, 5917.52659787216, 5486.945130548644, 5490.368607610176, 5502.944970550323, 5512.944870551323, 5532.640378375393, 5346.759395827197, 6381.202349706286, 6397.0404439332615, 6407.647579383085, 6412.35876412355, 6218.31598524171, 6219.129321895029, 6239.126522286792, 6269.811905642838, 6375.649339286384, 6288.339724328879, 6321.1782468278825, 6331.936680633319, 6357.0, 6370.585911915896, 6290.9056364155485, 6319.46284565817, 6323.652199129092, 6328.651924144032, 6335.2714437838395, 5813.476787089182, 6145.324014358328, 6258.0, 6360.681965901779, 6380.234371875405, 6106.885399019288, 6121.87979361315, 6153.815385538441, 6239.282482514387, 6252.155958945484, 6017.007193812972, 6209.0, 6238.594491358047, 6239.0, 6240.313565507699, 5903.970480147572, 6006.279246490449, 6020.8795824084145, 6089.725962331617, 6090.725917333642, 5067.923981140212, 6115.027386288435, 6124.663143527148, 6136.110264011782, 6241.407066328873, 6090.40666007058, 6098.176746139215, 6103.14402883062, 6117.724702388314, 6132.509399247961], "value": 5765.919183042115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.88218827481415, 520.0794593569382, 543.7390052774668, 549.9532539734122, 554.2517601238327, 33455.16362090946, 35753.64246357536, 38933.805330973344, 40070.59929400705, 40367.39448908265, 39431.21137577254, 41941.74174774754, 42306.576934230645, 42436.787816060954, 42549.787251063775, 9628.470434126139, 9823.066808653202, 9826.70519884401, 9827.754306142333, 9828.950855245714, 9639.180669643089, 9765.267604929622, 9770.90229097707, 9774.413535187876, 9782.168515676176, 9776.973417791136, 9826.803463930717, 9827.312088153796, 9827.803443931118, 9858.112769850712, 9722.0, 9781.951090244575, 9788.755281117958, 9789.021097890225, 9791.265655075898, 9639.518024098767, 9722.562484688206, 9723.513824308757, 9724.562394692255, 9734.951325243399, 39290.60709392927, 39660.0, 39672.60327396718, 39685.0, 39705.80882573499, 3550.254446566224, 3592.0840185752727, 3618.8914332569802, 3983.521977362706, 4140.964758810297, 29369.0, 29860.402791944256, 30226.697733022607, 30235.0, 31175.84412077925, 3191.7446604271604, 3198.296374797541, 3297.3075654112663, 3299.8185099819502, 3348.313595712873, 512398.0, 513332.43333783466, 513470.0, 514346.0, 515692.0, 55852.0, 56037.59906002301, 56135.71932140313, 56251.0, 56291.71854140785, 34659.82670086633, 35515.82242088773, 35550.11124721903, 36338.27323453516, 36397.45403818945, 15633.60915977087, 15749.842501574838, 15760.605984850241, 15769.211539422982, 15776.60558486047, 12698.80951785724, 12810.0, 12811.295378754072, 12819.294938778457, 12832.743345133045, 18194.270859370936, 18410.81589184091, 18451.0, 18558.44324670262, 18711.625767484573, 6746.494012949049, 7805.2194780521495, 7815.843683126305, 7873.291403773688, 7883.9605801971775, 880.348542078857, 974.9616658258932, 982.4400091947522, 1062.176812969939, 1100.0374672161859, 27047.323816904736, 28614.71385286162, 29111.0, 29442.852785736362, 29748.851255743582, 1040.7450174707244, 1071.7588542578014, 1094.3543309447305, 1098.5386137822134, 1107.1198397274025, 14400.711985760227, 14831.77752333716, 14913.850861491463, 15057.096574205583, 15463.845361546466, 690141.0, 762720.0, 775447.0, 775933.0, 777394.0, 58855.411445884994, 59562.702186488794, 59702.70148649229, 63461.68269158625, 63489.68255158787, 1325.443313808203, 1365.3582816076428, 1368.363710874448, 1431.6063082652354, 1456.3155317000992, 23451.296461106194, 31462.28600176351, 32207.516887246242, 32349.676503234667, 32626.184345391554, 55346.72326638341, 56004.43995560155, 56141.719291404916, 56151.43848561462, 56289.15566266427, 622718.0, 627730.0, 627976.0, 628024.0, 628613.0, 29720.851395742884, 36595.634043660284, 37076.07309817276, 38737.225255494166, 42836.571634284504, 43413.348799767395, 45644.77177614091, 45669.771651141535, 46076.078478429576, 46581.0, 31582.842085789423, 37938.62061379351, 38457.0, 38572.421413678254, 38839.80580097081, 37701.81149094237, 37912.0, 37961.81019094887, 39238.0, 39542.2091558173, 31275.218119547193, 36781.816090919376, 37069.0, 37598.81200594089, 37763.43354849624, 32914.0, 33740.66259337375, 34430.311393772485, 34494.310113798085, 34593.65406346005, 25164.370890727147, 25182.74817251804, 25322.366940826625, 25502.362440939123, 25857.0], "value": 20061.86795019591, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.73476953206966, 385.3352966133418, 395.3180763183508, 408.8078603056566, 414.56470705758943, 19400.90299548502, 21537.138514459402, 21594.89202553987, 21808.345749627497, 21826.363022773297, 20245.0, 20361.0, 20953.37139885802, 21168.89415552924, 21447.0, 4866.805327786902, 6001.0, 6168.47567956722, 6229.37706229378, 6241.4694750946, 4427.468703755554, 4671.813127474897, 4678.064387122572, 6642.136522252124, 6934.375906168469, 6620.205575330943, 6781.321867813229, 6948.409385202264, 6957.930420695779, 6982.441404687613, 6837.418819400357, 6886.862262754767, 6889.138857642794, 6892.965535172342, 6903.206131294915, 5760.53915686744, 5977.521798256129, 6043.848903777397, 6054.182685337467, 6071.483923866476, 25995.61006584903, 26272.73727262741, 26276.0, 26328.73671263301, 26396.340091497674, 2291.0, 2378.5242951409787, 2414.625733011386, 2432.063655492648, 3063.7242648161773, 16804.495865124067, 17500.374943758412, 17671.646567068714, 18540.62918741631, 18636.813631863643, 1780.6794776940146, 2004.979950200494, 2029.2694629933212, 2069.865458745192, 2191.9259562814264, 105819.0, 146465.0, 150761.0, 151207.0, 156083.0, 17821.910890445724, 21924.89037554802, 22272.65910113496, 22338.65444128343, 22507.598176437536, 36629.26741465209, 37066.07334816597, 37453.0, 37495.43756843649, 37544.87365379043, 10919.945400272947, 11084.501197446134, 11296.152788540892, 11326.886731132749, 11567.132465065153, 9166.724998250063, 9213.723588292361, 9214.44713317203, 9341.486218258062, 9352.672656457127, 9886.4562449066, 9983.650572230083, 10039.385821104397, 10076.848847267296, 10162.934826069632, 3070.6008218931397, 3782.6973842092566, 3802.448644946467, 3821.980635298083, 3926.1166237596885, 806.8023334283021, 881.6825942660637, 894.615315414365, 963.1476143612953, 1082.3830416662584, 20470.488237794176, 21396.679049814265, 21404.0, 21404.03681834321, 21458.89270553637, 924.5700749151677, 962.7785609309758, 967.2213867836318, 978.6085565773606, 984.5766320482261, 10481.213908956706, 11143.164262680331, 11183.608573700045, 11189.608363707232, 11195.936386043475, 609447.0, 610008.0, 611264.0, 624242.0, 624428.0, 125632.0, 129894.0, 130299.0, 131039.34480327538, 132268.67731322756, 978.3738407419257, 983.2920297385871, 992.5880759484877, 995.8705368302075, 996.9700908972742, 17251.326044463127, 18126.27494900189, 18778.624427511648, 18779.436616901516, 18781.81218187855, 54011.729941350044, 55505.88988220132, 55599.16601251066, 55754.72122639361, 56406.1539076906, 70736.64631676809, 76443.61778191074, 78179.21820781947, 82279.35441291261, 82910.0, 7323.890141647773, 8099.919000809917, 8111.918880811117, 8316.168383161636, 8492.065872754116, 9809.215262779104, 9903.801923961624, 12306.569270075504, 12507.187032842836, 12623.81064284018, 11012.229143959847, 11064.170187235828, 11074.723131921766, 11102.555897764, 11477.483513241757, 9803.509824508888, 10082.495875206358, 11141.665750027512, 11179.944100279447, 11523.193376463567, 10000.849987250052, 11195.320701894781, 11205.879412058728, 11244.775104498029, 11539.307641541534, 8165.061017983008, 8183.140770219041, 8466.153384661484, 8507.532085735096, 8539.914600854161, 10346.172306215636, 10766.461676915966, 10967.396793176453, 11208.831867522156, 11332.660020199408], "value": 10919.975962715245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.1495904813783, 1533.4096372896433, 1689.8732595055367, 1845.2157832921005, 1847.61200147969, 7945.761627151188, 8390.832183356337, 8435.409521333493, 8440.831183376336, 8456.0, 7494.175640679521, 7673.539587624747, 7993.0, 8189.262966333029, 8265.338772898169, 2366.2901129661077, 2400.1599440195964, 2400.867952262625, 2405.927822165338, 2409.0484258717797, 2405.170216275391, 2418.4921166555046, 2459.4712136890566, 2460.938476538083, 2461.938451538708, 2391.7488663690324, 2394.1500767227644, 2412.589859723851, 2419.9637005444933, 2433.7322894481595, 2379.8334116611845, 2383.9046438142454, 2407.735149133594, 2409.903603855844, 2416.6495858100475, 2410.68661074061, 2417.0573476344066, 2433.85396876188, 2434.6591477193206, 2436.9512609747885, 8326.583670816495, 8367.037790654093, 8436.789080273042, 8440.113788052227, 8441.662333506652, 5117.0, 5275.155975043975, 5277.86805329866, 5282.656627319212, 5284.762185701614, 3184.092533627928, 3500.789952602852, 3509.771864828778, 3515.54297941266, 3591.712662986955, 1003.7440452684592, 1022.4734261855151, 1033.8604288421043, 1079.13129930406, 1079.983800242997, 10258.17934565233, 10345.741356466073, 10347.896521034769, 10356.016178463035, 10379.3253438527, 4480.395146655225, 4525.04973955473, 4609.331646911179, 4614.792334344896, 4787.42550893895, 7535.246475352531, 9432.858507122399, 9439.858402123973, 9457.810843783085, 9470.715878523655, 5260.342457192851, 5261.131913234273, 5263.447338029452, 5263.921041184385, 5273.31446911899, 4378.540253273361, 4502.0, 4709.8351557696005, 4780.4741478437345, 4842.249451335048, 3826.4069069294305, 3856.9228615427533, 3915.7258991870867, 3961.7028722845903, 3962.782046987386, 1278.3544310123327, 1289.9032572557096, 1293.1077556485996, 1300.0509627971444, 1303.6219496346143, 914.8627705844177, 917.4449458077901, 918.2332752152028, 927.7495076329488, 958.2621381536178, 5615.185798059259, 5747.942520574741, 5880.588358814842, 5957.285125784933, 6087.543434242361, 915.4461550761827, 944.187998321443, 952.8570714392758, 954.9570269337896, 970.6748239339901, 3739.476473293741, 3854.730168888207, 3863.285292220948, 3934.409838524244, 4012.4181993610764, 9709.320347575744, 10148.949255253676, 10179.440130792878, 10216.540255688511, 10293.0, 8833.734987950373, 9049.095090490899, 9288.374534456443, 10141.29010969225, 10148.238882083873, 7666.65500052499, 7880.960595196987, 7895.210478952174, 7902.525848449226, 7935.127136015034, 5661.405552417102, 5691.4877661010705, 5724.713764311685, 5856.707164641836, 5908.379620139824, 7776.416768742254, 9137.360384773268, 9270.582823772811, 9467.2426205902, 9525.476098814632, 9193.448393096436, 9446.433214007182, 9573.760655983377, 9573.899001614625, 9575.0, 5873.4126587342635, 6673.366030227121, 6872.41584465306, 7078.504504684623, 7217.6752046157, 7872.252136047066, 7890.605469726605, 8007.759767206993, 8012.078610959814, 8020.558869262247, 7067.893981590383, 7214.71141154348, 7228.31331023552, 7240.96379518099, 7337.3763230123905, 6993.125859267591, 7063.364297213276, 7070.68181931804, 7185.958036084843, 7209.675564599501, 6666.400023997863, 6683.264840867403, 6734.629595372302, 6750.493712971645, 6753.0, 4879.268109783561, 4910.803567857246, 4911.140550403594, 4922.089413458521, 4946.554810067111, 4857.101436234308, 4864.173090574682, 4889.731064791471, 4935.506449355179, 5069.99735104639], "value": 4470.279474895055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4829049163963, 300.5671832561112, 308.70981277599054, 313.03116853338906, 315.0187166974874, 4692.859214223575, 5092.772998411309, 5267.762950667219, 5270.522854258497, 5273.5781137509, 4328.545502722216, 4561.947123794289, 4733.266343716721, 5195.532402083812, 5232.555232805206, 3272.132884785534, 3459.342724882277, 3984.6413822755944, 4000.3599424092004, 4017.658499027586, 3992.2414741199223, 4001.5798341174195, 4011.65900898424, 4012.919741605166, 4025.919481610366, 3667.413213885779, 3933.213357328546, 3973.582773808752, 3991.521017477892, 4004.9186719585696, 3921.686265098785, 3951.8616848410456, 3967.305721498726, 3971.682265418774, 3999.1601763629674, 3387.4749413840896, 3397.8640854365794, 3404.676555727202, 3406.5230867678547, 3425.5546778918583, 4607.907841843178, 4669.32294817253, 5100.0, 5127.564157046618, 5169.483051694838, 3731.8693845715543, 4415.536368681274, 4496.9325460118125, 4506.639468842484, 4506.639468842484, 4759.738214398207, 5453.773325672596, 5497.45025497451, 5497.670139791625, 5503.752331145108, 3749.4750734897134, 3755.267722794056, 3758.868439604628, 3774.1885494618787, 3789.4315852622326, 4960.702357858504, 5481.917771233435, 5531.502164805147, 5692.800751973702, 5782.306123265193, 3406.9659303407143, 3439.81326442382, 3691.630836916287, 3696.5194524711615, 3705.7591256568776, 3752.3433399155037, 3873.903152421212, 3891.3579259422445, 3895.902602434905, 3912.256671232514, 4202.831886724558, 4440.3339499074755, 4500.302453119772, 4507.498338422141, 4510.36854840316, 4855.757212139379, 5109.463506331856, 5337.893242135136, 5550.750216240279, 5593.692346920877, 1108.7449886526144, 1232.9445174967148, 1240.7394447166016, 1262.7183408840035, 1287.1440492072854, 742.8040854224694, 836.3560058754846, 848.5587494502947, 857.562643052048, 867.3234876796109, 4724.00795832879, 4726.71639701619, 4961.70229786214, 4968.931679688884, 4971.502849715, 5283.841484755463, 5307.601929855199, 5323.604378029902, 5376.973115134399, 5403.487023633389, 3807.371783655721, 3912.691512007929, 4387.670924680661, 4441.933370999438, 4724.842413608688, 2430.6840110785483, 2815.3389500194985, 2822.50606143924, 2838.815476993989, 2844.6728626207837, 4750.857474275777, 4829.251466022772, 4860.535487801216, 4972.577330926912, 5605.495505404451, 5237.266782650432, 5500.7524661390335, 5519.013155264101, 5519.282493275929, 5525.502704756591, 4550.565447485579, 4782.019685964438, 5422.620416570802, 5550.91673624896, 5576.657803722446, 4936.136176169084, 5233.424323324355, 5337.930689853272, 5362.65142765719, 5412.377576578744, 4573.725576465423, 4737.786799594095, 5219.269302297757, 5303.851939964321, 5696.515796157373, 5712.971435142797, 5850.888331217056, 6017.398260173947, 6032.698365081641, 6044.818655440344, 3713.9257214856093, 3727.1800203955086, 3787.242551489658, 3818.312703713358, 3845.5000849889334, 4652.348671185969, 5139.815578379099, 5256.4743525648655, 5570.359408668055, 5758.222639943554, 5444.401115877171, 5523.9894257628885, 5555.72221388937, 5579.218909352613, 5623.297087864017, 4749.860033591844, 5277.2875661785165, 5523.613347065828, 5548.334199896039, 5564.554835613222, 5410.891782164256, 5432.538234250133, 5435.972820135874, 5437.0, 5511.0, 5255.9211611825085, 5489.945100548944, 5511.669299842022, 5534.944650553443, 5558.832645144565, 5422.8373148805595, 5426.8371948841595, 5428.240046393587, 5442.374126975448, 5448.427915069019], "value": 3952.476606594698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8953157026446, 760.8744557148071, 779.7465823607328, 811.7686459359084, 845.8604330285503, 14685.853141468582, 15467.845321546782, 15543.300551475182, 15609.921950390246, 15638.687226255468, 13939.233342166202, 14090.436382544685, 14093.224872632027, 14112.082714623568, 14121.43514259431, 685.3352248319147, 704.1128178495107, 707.0560801330205, 827.9958600206991, 859.0593300336153, 837.9832403351929, 856.5160684213399, 858.3648100405686, 858.4076986879064, 858.4849090545654, 903.7966457547066, 908.8954770201412, 909.6816114359988, 909.6816114359988, 909.8316811389881, 904.6607522179182, 904.8371293167228, 905.3300557587404, 905.9365844390895, 906.4289497616526, 668.7091115364832, 672.0993868216565, 672.6031641331638, 672.8721542906832, 672.9259781424039, 14523.782143267754, 14729.631759206106, 14760.852391476055, 14771.409143634242, 15071.191457025117, 14200.431982720678, 14614.415423383158, 14628.195449250286, 14814.0, 14856.480023199136, 10803.621873234399, 11344.376059316734, 11379.943100284529, 11756.764864702744, 11760.470778814888, 4584.701994370355, 4643.2802915548145, 4711.199096153662, 4792.616590672737, 4808.855734327941, 93239.13521729528, 93556.06443935541, 94460.0, 95776.52111739466, 95810.0, 10388.324758890649, 10705.678829635124, 10760.085392741548, 10884.945575272073, 10963.574735284363, 19260.614787704446, 19576.0, 19675.01624918777, 19845.900770496057, 19855.503612409517, 7902.644381002754, 8064.395170362129, 8067.273945344947, 8079.434439589172, 8136.511809291462, 4502.347159661831, 4504.166729155117, 4581.587657110809, 4588.7935042923145, 4692.741899195509, 2860.3993161436333, 3488.7383446241633, 3508.5088087667746, 3512.929741405209, 3520.190356218084, 668.866226754651, 676.7529851604129, 677.8949262864264, 686.1012074182836, 687.6630451078935, 567.1266249975075, 580.080572292912, 617.413457215638, 690.975815846443, 698.7309885694044, 8829.0, 9235.722928312027, 9264.72205833826, 9396.765080873032, 9468.28987825902, 648.8896887529131, 659.4328877165634, 676.7834293026184, 710.4919982212639, 719.8380364417964, 4035.616616421435, 4289.0, 4551.658625603093, 4555.908881822345, 4584.426946631671, 69185.65407172932, 94290.11419771567, 105353.0, 106887.0, 113406.86593134128, 63640.363596363444, 65268.0, 81322.59338703268, 99791.0, 100623.99376006146, 91680.6247906282, 93104.3750933251, 93238.0676193243, 93953.06046939443, 96101.31189504823, 8535.402521823413, 8846.911530884867, 8972.955135224543, 9058.139476749699, 9698.124311141899, 39035.21929561449, 39919.401208981304, 48402.0, 50496.747516262185, 52405.23542410255, 70266.0, 73127.26872731204, 75615.0, 77756.61121694355, 78531.21468785239, 12568.937155314165, 12805.103642744918, 12923.547675831302, 13062.54281100157, 13220.933895330461, 13437.798433023709, 13776.724465510833, 14142.717145657234, 14440.927795360956, 14490.275486225435, 13167.078304518593, 13261.53584624572, 14173.291335433394, 14419.927900360432, 14785.704285914006, 12853.357332133543, 13830.65423364424, 14153.221572813594, 14783.260836957894, 14815.25923703832, 11451.942740286246, 14016.78974815399, 14075.296235188405, 14355.497557585435, 14371.353289101806, 9813.264005199495, 11115.333080015225, 11578.536858525564, 11793.882061179278, 11944.462499187384, 9582.520873956135, 10091.596336146471, 11092.445377730919, 11444.542218311175, 11459.942700286445], "value": 7479.595917974683, "unit": "score"}], "name": "dromaeo_css", "value": 7420.4868014819585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 114.0, 111.0, 114.0, 114.0, 117.0, 158.0, 165.0], "value": 122.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 106.0, 140.0, 108.0, 108.0, 110.0, 131.0, 172.0, 105.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 181.0, 184.0, 182.0, 182.0, 183.0, 183.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 60.0, 59.0, 74.0, 82.0, 109.0, 64.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 92.0, 82.0, 96.0, 100.0, 113.0, 69.0, 68.0, 90.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 130.0, 135.0, 97.0, 91.0, 91.0, 94.0, 88.0], "value": 98.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 108.0, 150.0, 148.0, 116.0, 94.0, 94.0], "value": 109.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 83.0, 82.0, 86.0, 129.0, 91.0, 84.0, 81.0], "value": 88.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 52.0, 54.0, 57.0, 56.0, 57.0, 53.0, 55.0, 76.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 70.0, 74.0, 71.0, 67.0, 68.0, 68.0, 67.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 82.0, 82.0, 81.0, 81.0, 82.0, 84.0, 81.0, 83.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 136.0, 113.0, 145.0, 149.0, 155.0, 157.0, 183.0, 148.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 166.0, 160.0, 160.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1464.9, "alertThreshold": 2.0}]} 09:41:03 INFO - Return code: 0 09:41:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:03 INFO - # TBPL SUCCESS # 09:41:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:03 INFO - 2017-01-25 09:41:03.945 screenresolution[1655:9782] starting screenresolution argv=screenresolution get 09:41:03 INFO - 2017-01-25 09:41:03.949 screenresolution[1655:9782] Display 0: 1600x1200x32@60 09:41:03 INFO - 2017-01-25 09:41:03.956 screenresolution[1656:9785] starting screenresolution argv=screenresolution list 09:41:03 INFO - Available Modes on Display 0 09:41:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:04 INFO - Intel Iris: 09:41:04 INFO - Chipset Model: Intel Iris 09:41:04 INFO - Type: GPU 09:41:04 INFO - Bus: Built-In 09:41:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:04 INFO - Vendor: Intel (0x8086) 09:41:04 INFO - Device ID: 0x0a2e 09:41:04 INFO - Revision ID: 0x0009 09:41:04 INFO - Displays: 09:41:04 INFO - Display: 09:41:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:04 INFO - Display Serial Number: 1600x1200 60 09:41:04 INFO - Main Display: Yes 09:41:04 INFO - Mirror: Off 09:41:04 INFO - Online: Yes 09:41:04 INFO - Rotation: Supported 09:41:04 INFO - Return code: 0 09:41:04 INFO - Running post-action listener: _resource_record_post_action 09:41:04 INFO - [mozharness: 2017-01-25 17:41:04.197512Z] Finished run-tests step (success) 09:41:04 INFO - Running post-run listener: _resource_record_post_run 09:41:04 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 38020096; Write bytes: 494286848; Read time: 242; Write time: 1567 09:41:04 INFO - TinderboxPrint: CPU usage
53.5% 09:41:04 INFO - TinderboxPrint: I/O read bytes / time
38,020,096 / 242 09:41:04 INFO - TinderboxPrint: I/O write bytes / time
494,286,848 / 1,567 09:41:04 INFO - TinderboxPrint: CPU idle
2,233.2 (46.5%) 09:41:04 INFO - TinderboxPrint: CPU system
961.7 (20.0%) 09:41:04 INFO - TinderboxPrint: CPU user
1,602.8 (33.4%) 09:41:04 INFO - TinderboxPrint: Swap in / out
229,281,792 / 0 09:41:04 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 176843264; Write bytes: 175601664; Read time: 16486; Write time: 393 09:41:04 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37098496; Write bytes: 300953600; Read time: 230; Write time: 1119 09:41:04 INFO - Running post-run listener: _upload_blobber_files 09:41:04 INFO - Blob upload gear active. 09:41:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:04 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:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:06 INFO - (blobuploader) - INFO - Done attempting. 09:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:07 INFO - (blobuploader) - INFO - Done attempting. 09:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:09 INFO - (blobuploader) - INFO - Done attempting. 09:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:09 INFO - Return code: 0 09:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd82410eb371838fe696e2e5b209f80abae0ad6d9cb04d3dec6a240f11638db9032a505989d8deee56504a8856b5d4c73dd4b4f5ba458c1c661883a26d4b6305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d7b761c967e1bc4a40b9eeb75be0280c7f15b0ca2866546d3fde3f8057706acd103f6dc8ab1f937c1bdac013bb110512942c679ddc67c085320f5147074dab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d34f577ef7cf80c806d306fa0f4e313d9414b0a5ba551e6df8a401a1964d8e90b1a433a99136e2ea096847523e1956b198cd4feec54274eef0e5ceb154a8943"} 09:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:09 INFO - Contents: 09:41:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd82410eb371838fe696e2e5b209f80abae0ad6d9cb04d3dec6a240f11638db9032a505989d8deee56504a8856b5d4c73dd4b4f5ba458c1c661883a26d4b6305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d7b761c967e1bc4a40b9eeb75be0280c7f15b0ca2866546d3fde3f8057706acd103f6dc8ab1f937c1bdac013bb110512942c679ddc67c085320f5147074dab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d34f577ef7cf80c806d306fa0f4e313d9414b0a5ba551e6df8a401a1964d8e90b1a433a99136e2ea096847523e1956b198cd4feec54274eef0e5ceb154a8943"} 09:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:09 INFO - Copying logs to upload dir... 09:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.892896 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-25 09:41:09.468159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 09:41:09.472738) ========= 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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd82410eb371838fe696e2e5b209f80abae0ad6d9cb04d3dec6a240f11638db9032a505989d8deee56504a8856b5d4c73dd4b4f5ba458c1c661883a26d4b6305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d7b761c967e1bc4a40b9eeb75be0280c7f15b0ca2866546d3fde3f8057706acd103f6dc8ab1f937c1bdac013bb110512942c679ddc67c085320f5147074dab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d34f577ef7cf80c806d306fa0f4e313d9414b0a5ba551e6df8a401a1964d8e90b1a433a99136e2ea096847523e1956b198cd4feec54274eef0e5ceb154a8943"} build_url:https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010415 build_url: 'https://queue.taskcluster.net/v1/task/HD_9zaQySNaDlcOeQq84Jg/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd82410eb371838fe696e2e5b209f80abae0ad6d9cb04d3dec6a240f11638db9032a505989d8deee56504a8856b5d4c73dd4b4f5ba458c1c661883a26d4b6305", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d7b761c967e1bc4a40b9eeb75be0280c7f15b0ca2866546d3fde3f8057706acd103f6dc8ab1f937c1bdac013bb110512942c679ddc67c085320f5147074dab0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d34f577ef7cf80c806d306fa0f4e313d9414b0a5ba551e6df8a401a1964d8e90b1a433a99136e2ea096847523e1956b198cd4feec54274eef0e5ceb154a8943"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 09:41:09.508726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 09:41:09.509093) ========= 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.7VW2joXVVS/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.qEUiaJ5HAF/Listeners TMPDIR=/var/folders/v6/pkqdmfh94j76xzqgv7yrqmr000000w/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.005255 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 09:41:09.557182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 09:41:09.557513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 09:41:09.557840) ========= ========= Total master_lag: 0.21 =========