builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0100 starttime: 1479399615.61 results: success (0) buildid: 20161117060328 builduid: 90eed37f8d6b4a1c8ca3e39364311e86 revision: 64936ba0330a72cf5e05bca5f44b84562705fea0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.609378) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.609911) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.610204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.635695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.636023) ========= 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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 08:20:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.6M=0s 2016-11-17 08:20:15 (26.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.746007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.746341) ========= 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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.027660 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:15.794535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 08:20:15.794916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64936ba0330a72cf5e05bca5f44b84562705fea0 --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-aurora --rev 64936ba0330a72cf5e05bca5f44b84562705fea0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 08:20:15,890 truncating revision to first 12 chars 2016-11-17 08:20:15,890 Setting DEBUG logging. 2016-11-17 08:20:15,890 attempt 1/10 2016-11-17 08:20:15,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/64936ba0330a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 08:20:16,945 unpacking tar archive at: mozilla-aurora-64936ba0330a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.356045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 08:20:17.173637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:17.174017) ========= script_repo_revision: 64936ba0330a72cf5e05bca5f44b84562705fea0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:17.174460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:17.174734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 08:20:17.193571) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-17 08:20:17.193867) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:20:17 INFO - MultiFileLogger online at 20161117 08:20:17 in /builds/slave/test 08:20:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:20:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:17 INFO - {'append_to_log': False, 08:20:17 INFO - 'base_work_dir': '/builds/slave/test', 08:20:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:20:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:17 INFO - 'branch': 'Mozilla-Aurora', 08:20:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:17 INFO - 'config_files': ('talos/mac_config.py',), 08:20:17 INFO - 'default_actions': ('clobber', 08:20:17 INFO - 'read-buildbot-config', 08:20:17 INFO - 'download-and-extract', 08:20:17 INFO - 'populate-webroot', 08:20:17 INFO - 'create-virtualenv', 08:20:17 INFO - 'install', 08:20:17 INFO - 'run-tests'), 08:20:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:17 INFO - 'download_minidump_stackwalk': True, 08:20:17 INFO - 'download_symbols': 'ondemand', 08:20:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:17 INFO - 'installer_path': 'installer.exe', 08:20:17 INFO - 'log_level': 'info', 08:20:17 INFO - 'log_name': 'talos', 08:20:17 INFO - 'log_to_console': True, 08:20:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:20:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:20:17 INFO - 'opt_config_files': (), 08:20:17 INFO - 'pip_index': False, 08:20:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:20:17 INFO - 'cmd': ('bash', 08:20:17 INFO - '-c', 08:20:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:20:17 INFO - 'enabled': True, 08:20:17 INFO - 'halt_on_failure': False, 08:20:17 INFO - 'name': 'check_screen_resolution'},), 08:20:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:20:17 INFO - 'cmd': ('bash', 08:20:17 INFO - '-c', 08:20:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:20:17 INFO - 'enabled': True, 08:20:17 INFO - 'halt_on_failure': False, 08:20:17 INFO - 'name': 'check_screen_resolution'},), 08:20:17 INFO - 'run_cmd_checks_enabled': True, 08:20:17 INFO - 'sps_profile': False, 08:20:17 INFO - 'sps_profile_interval': 0, 08:20:17 INFO - 'suite': 'dromaeojs-e10s', 08:20:17 INFO - 'system_bits': '32', 08:20:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:17 INFO - 'title': 't-yosemite-r7-0100', 08:20:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:17 INFO - 'use_talos_json': True, 08:20:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:17 INFO - 'work_dir': 'build'} 08:20:17 INFO - [mozharness: 2016-11-17 16:20:17.403120Z] Running clobber step. 08:20:17 INFO - Running pre-action listener: _resource_record_pre_action 08:20:17 INFO - Running main action method: clobber 08:20:17 INFO - rmtree: /builds/slave/test/build 08:20:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:19 INFO - Running post-action listener: _resource_record_post_action 08:20:19 INFO - [mozharness: 2016-11-17 16:20:19.752607Z] Finished clobber step (success) 08:20:19 INFO - [mozharness: 2016-11-17 16:20:19.752822Z] Running read-buildbot-config step. 08:20:19 INFO - Running pre-action listener: _resource_record_pre_action 08:20:19 INFO - Running main action method: read_buildbot_config 08:20:19 INFO - Using buildbot properties: 08:20:19 INFO - { 08:20:19 INFO - "project": "", 08:20:19 INFO - "product": "firefox", 08:20:19 INFO - "script_repo_revision": "production", 08:20:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:20:19 INFO - "repository": "", 08:20:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:20:19 INFO - "buildid": "20161117060328", 08:20:19 INFO - "pgo_build": "False", 08:20:19 INFO - "basedir": "/builds/slave/test", 08:20:19 INFO - "buildnumber": 44, 08:20:19 INFO - "slavename": "t-yosemite-r7-0100", 08:20:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:20:19 INFO - "platform": "yosemite_r7", 08:20:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:20:19 INFO - "branch": "mozilla-aurora", 08:20:19 INFO - "repo_path": "releases/mozilla-aurora", 08:20:19 INFO - "revision": "64936ba0330a72cf5e05bca5f44b84562705fea0", 08:20:19 INFO - "stage_platform": "macosx64", 08:20:19 INFO - "builduid": "90eed37f8d6b4a1c8ca3e39364311e86", 08:20:19 INFO - "slavebuilddir": "test" 08:20:19 INFO - } 08:20:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:20:19 INFO - Running post-action listener: _resource_record_post_action 08:20:19 INFO - [mozharness: 2016-11-17 16:20:19.758559Z] Finished read-buildbot-config step (success) 08:20:19 INFO - [mozharness: 2016-11-17 16:20:19.758737Z] Running download-and-extract step. 08:20:19 INFO - Running pre-action listener: _resource_record_pre_action 08:20:19 INFO - Running main action method: download_and_extract 08:20:19 INFO - mkdir: /builds/slave/test/build/tests 08:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:19 INFO - trying https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:20:19 INFO - Downloading https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:20:21 INFO - Downloaded 1199 bytes. 08:20:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:20:21 INFO - Using the following test package requirements: 08:20:21 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:20:21 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:20:21 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:20:21 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'jsshell-mac.zip'], 08:20:21 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:20:21 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:20:21 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:20:21 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:20:21 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:20:21 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:20:21 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:20:21 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:20:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:20:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:20:21 INFO - Fetch https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:20:21 INFO - Http code: 200 08:20:21 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:20:21 INFO - x-amz-cf-id: iV9hk7LpBqLX4QvUp6qHQg-zuVHtuzQgP-ItT2BWp_UGjsAkh5vEEQ== 08:20:21 INFO - x-amz-version-id: vE8ATG25ZNGbSYCCmIBagZK8YKyGMPeW 08:20:22 INFO - Expected file size: 16327483 08:20:22 INFO - Obtained file size: 16327483 08:20:28 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:20:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:20:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:20:28 INFO - Fetch https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:20:29 INFO - Http code: 200 08:20:29 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:20:29 INFO - x-amz-cf-id: 814un7MqHGWdToIvVNkKVu2C-PtEpv0SYpzj2wsVOlwwQXJdXQuAuw== 08:20:29 INFO - x-amz-version-id: vE8ATG25ZNGbSYCCmIBagZK8YKyGMPeW 08:20:29 INFO - Expected file size: 16327483 08:20:29 INFO - Obtained file size: 16327483 08:20:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:20:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:20:36 INFO - Fetch https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:20:37 INFO - Http code: 200 08:20:37 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 08:20:37 INFO - x-amz-cf-id: H7WD10SsPXrlZCP877s30FdmVjixm94479BKji_GYLRwDCn4gi-B0Q== 08:20:37 INFO - x-amz-version-id: prRw.YuJzOBaqO_EZtM9Msp2uRlOAqsq 08:20:37 INFO - Expected file size: 14409038 08:20:37 INFO - Obtained file size: 14409038 08:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:37 INFO - trying https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:20:37 INFO - Downloading https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:20:41 INFO - Downloaded 114364579 bytes. 08:20:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:20:41 INFO - mkdir: /builds/slave/test/properties 08:20:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:41 INFO - Contents: 08:20:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:20:41 INFO - Running post-action listener: _resource_record_post_action 08:20:41 INFO - Running post-action listener: set_extra_try_arguments 08:20:41 INFO - [mozharness: 2016-11-17 16:20:41.895486Z] Finished download-and-extract step (success) 08:20:41 INFO - [mozharness: 2016-11-17 16:20:41.895604Z] Running populate-webroot step. 08:20:41 INFO - Running pre-action listener: _resource_record_pre_action 08:20:41 INFO - Running main action method: populate_webroot 08:20:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:41 INFO - '--tppagecycles', 08:20:41 INFO - '7'], 08:20:41 INFO - 'tests': ['tsvgm']}}, 08:20:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:20:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['damp', 'tps']}, 08:20:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'tests': ['damp', 'tps']}, 08:20:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['dromaeo_dom']}, 08:20:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['basic_compositor_video']}, 08:20:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:20:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['a11yr', 08:20:41 INFO - 'ts_paint', 08:20:41 INFO - 'tpaint', 08:20:41 INFO - 'sessionrestore', 08:20:41 INFO - 'sessionrestore_no_auto_restore', 08:20:41 INFO - 'tabpaint']}, 08:20:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:41 INFO - 'ts_paint', 08:20:41 INFO - 'tpaint', 08:20:41 INFO - 'sessionrestore', 08:20:41 INFO - 'sessionrestore_no_auto_restore', 08:20:41 INFO - 'tabpaint']}, 08:20:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:20:41 INFO - 'ts_paint', 08:20:41 INFO - 'tpaint', 08:20:41 INFO - 'sessionrestore', 08:20:41 INFO - 'sessionrestore_no_auto_restore', 08:20:41 INFO - 'tabpaint']}, 08:20:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:20:41 INFO - 'ts_paint', 08:20:41 INFO - 'tpaint', 08:20:41 INFO - 'sessionrestore', 08:20:41 INFO - 'sessionrestore_no_auto_restore', 08:20:41 INFO - 'tabpaint']}, 08:20:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['a11yr', 08:20:41 INFO - 'ts_paint', 08:20:41 INFO - 'tpaint', 08:20:41 INFO - 'sessionrestore', 08:20:41 INFO - 'sessionrestore_no_auto_restore', 08:20:41 INFO - 'tabpaint']}, 08:20:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['a11yr', 08:20:41 INFO - 'ts_paint', 08:20:41 INFO - 'tpaint', 08:20:41 INFO - 'sessionrestore', 08:20:41 INFO - 'sessionrestore_no_auto_restore', 08:20:41 INFO - 'tabpaint']}, 08:20:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['tsvgx', 08:20:41 INFO - 'tsvgr_opacity', 08:20:41 INFO - 'tart', 08:20:41 INFO - 'tscrollx', 08:20:41 INFO - 'cart']}, 08:20:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:41 INFO - 'tsvgr_opacity', 08:20:41 INFO - 'tart', 08:20:41 INFO - 'tscrollx', 08:20:41 INFO - 'cart']}, 08:20:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'talos_options': ['--disable-e10s'], 08:20:41 INFO - 'tests': ['tp5o']}, 08:20:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'tests': ['tp5o']}, 08:20:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'talos_options': ['--disable-e10s', 08:20:41 INFO - '--xperf_path', 08:20:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:41 INFO - 'tests': ['tp5n']}, 08:20:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:41 INFO - 'talos_options': ['--xperf_path', 08:20:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:41 INFO - 'tests': ['tp5n']}}, 08:20:41 INFO - 'talos.zip': {'path': '', 08:20:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:41 INFO - Running post-action listener: _resource_record_post_action 08:20:41 INFO - [mozharness: 2016-11-17 16:20:41.914171Z] Finished populate-webroot step (success) 08:20:41 INFO - [mozharness: 2016-11-17 16:20:41.914272Z] Running create-virtualenv step. 08:20:41 INFO - Running pre-action listener: _resource_record_pre_action 08:20:41 INFO - Running main action method: create_virtualenv 08:20:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:42 INFO - Using real prefix '/tools/python27' 08:20:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:45 INFO - Installing pip.................done. 08:20:45 INFO - Return code: 0 08:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:20:45 INFO - Reading from file tmpfile_stdout 08:20:45 INFO - Output received: 08:20:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:20:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:20:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:20:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:45 INFO - 'HOME': '/Users/cltbld', 08:20:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:45 INFO - 'LOGNAME': 'cltbld', 08:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:45 INFO - 'MOZ_NO_REMOTE': '1', 08:20:45 INFO - 'NO_EM_RESTART': '1', 08:20:45 INFO - 'PAGER': '/bin/cat', 08:20:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:45 INFO - 'PWD': '/builds/slave/test', 08:20:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:45 INFO - 'SHELL': '/bin/bash', 08:20:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:20:45 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:20:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:45 INFO - 'USER': 'cltbld', 08:20:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:45 INFO - 'XPC_FLAGS': '0x0', 08:20:45 INFO - 'XPC_SERVICE_NAME': '0', 08:20:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:20:46 INFO - Cleaning up... 08:20:46 INFO - Return code: 0 08:20:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', '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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08: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 psutil>=3.1.1 08:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:46 INFO - 'HOME': '/Users/cltbld', 08:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:46 INFO - 'LOGNAME': 'cltbld', 08:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:46 INFO - 'MOZ_NO_REMOTE': '1', 08:20:46 INFO - 'NO_EM_RESTART': '1', 08:20:46 INFO - 'PAGER': '/bin/cat', 08:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:46 INFO - 'PWD': '/builds/slave/test', 08:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:46 INFO - 'SHELL': '/bin/bash', 08:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:20:46 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:46 INFO - 'USER': 'cltbld', 08:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:46 INFO - 'XPC_FLAGS': '0x0', 08:20:46 INFO - 'XPC_SERVICE_NAME': '0', 08:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:46 INFO - Downloading/unpacking psutil>=3.1.1 08: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 08: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 08: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 08: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 08: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 08: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 08:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:49 INFO - Installing collected packages: psutil 08:20:49 INFO - Running setup.py install for psutil 08:20:50 INFO - building 'psutil._psutil_osx' extension 08:20:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:20:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:20:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:20:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:20:50 INFO - building 'psutil._psutil_posix' extension 08:20:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:20:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:20:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:20:50 INFO - ^ 08:20:50 INFO - 1 warning generated. 08:20:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:20:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:51 INFO - Successfully installed psutil 08:20:51 INFO - Cleaning up... 08:20:51 INFO - Return code: 0 08:20:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:51 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:51 INFO - 'HOME': '/Users/cltbld', 08:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:51 INFO - 'LOGNAME': 'cltbld', 08:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:51 INFO - 'MOZ_NO_REMOTE': '1', 08:20:51 INFO - 'NO_EM_RESTART': '1', 08:20:51 INFO - 'PAGER': '/bin/cat', 08:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:51 INFO - 'PWD': '/builds/slave/test', 08:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:51 INFO - 'SHELL': '/bin/bash', 08:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:20:51 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:51 INFO - 'USER': 'cltbld', 08:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:51 INFO - 'XPC_FLAGS': '0x0', 08:20:51 INFO - 'XPC_SERVICE_NAME': '0', 08:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:54 INFO - Installing collected packages: mozsystemmonitor 08:20:54 INFO - Running setup.py install for mozsystemmonitor 08:20:54 INFO - Successfully installed mozsystemmonitor 08:20:54 INFO - Cleaning up... 08:20:54 INFO - Return code: 0 08:20:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:54 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:54 INFO - 'HOME': '/Users/cltbld', 08:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:54 INFO - 'LOGNAME': 'cltbld', 08:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:54 INFO - 'MOZ_NO_REMOTE': '1', 08:20:54 INFO - 'NO_EM_RESTART': '1', 08:20:54 INFO - 'PAGER': '/bin/cat', 08:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:54 INFO - 'PWD': '/builds/slave/test', 08:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:54 INFO - 'SHELL': '/bin/bash', 08:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:20:54 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:54 INFO - 'USER': 'cltbld', 08:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:54 INFO - 'XPC_FLAGS': '0x0', 08:20:54 INFO - 'XPC_SERVICE_NAME': '0', 08:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:57 INFO - warning: no files found matching '*.txt' 08:20:57 INFO - no previously-included directories found matching 'build' 08:20:57 INFO - no previously-included directories found matching 'dist' 08:20:57 INFO - no previously-included directories found matching '.git*' 08:20:57 INFO - Installing collected packages: jsonschema, functools32 08:20:57 INFO - Running setup.py install for functools32 08:20:57 INFO - warning: no files found matching '*.txt' 08:20:57 INFO - no previously-included directories found matching 'build' 08:20:57 INFO - no previously-included directories found matching 'dist' 08:20:57 INFO - no previously-included directories found matching '.git*' 08:20:57 INFO - Successfully installed jsonschema functools32 08:20:57 INFO - Cleaning up... 08:20:57 INFO - Return code: 0 08:20:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:57 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:20:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:20:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:57 INFO - 'HOME': '/Users/cltbld', 08:20:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:57 INFO - 'LOGNAME': 'cltbld', 08:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:57 INFO - 'MOZ_NO_REMOTE': '1', 08:20:57 INFO - 'NO_EM_RESTART': '1', 08:20:57 INFO - 'PAGER': '/bin/cat', 08:20:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:57 INFO - 'PWD': '/builds/slave/test', 08:20:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:57 INFO - 'SHELL': '/bin/bash', 08:20:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:20:57 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:20:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:57 INFO - 'USER': 'cltbld', 08:20:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:57 INFO - 'XPC_FLAGS': '0x0', 08:20:57 INFO - 'XPC_SERVICE_NAME': '0', 08:20:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:58 INFO - Cleaning up... 08:20:58 INFO - Return code: 0 08:20:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:58 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:58 INFO - 'HOME': '/Users/cltbld', 08:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:58 INFO - 'LOGNAME': 'cltbld', 08:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:58 INFO - 'MOZ_NO_REMOTE': '1', 08:20:58 INFO - 'NO_EM_RESTART': '1', 08:20:58 INFO - 'PAGER': '/bin/cat', 08:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:58 INFO - 'PWD': '/builds/slave/test', 08:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:58 INFO - 'SHELL': '/bin/bash', 08:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:20:58 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:58 INFO - 'USER': 'cltbld', 08:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:58 INFO - 'XPC_FLAGS': '0x0', 08:20:58 INFO - 'XPC_SERVICE_NAME': '0', 08:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:58 INFO - Downloading/unpacking blobuploader==1.2.4 08: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 08: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 08: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 08: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 08: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 08: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 08:21:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:02 INFO - Downloading docopt-0.6.1.tar.gz 08:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:02 INFO - Running setup.py install for blobuploader 08:21:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:02 INFO - Running setup.py install for requests 08:21:02 INFO - Running setup.py install for docopt 08:21:03 INFO - Successfully installed blobuploader requests docopt 08:21:03 INFO - Cleaning up... 08:21:03 INFO - Return code: 0 08:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:03 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:03 INFO - 'HOME': '/Users/cltbld', 08:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:03 INFO - 'LOGNAME': 'cltbld', 08:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:03 INFO - 'MOZ_NO_REMOTE': '1', 08:21:03 INFO - 'NO_EM_RESTART': '1', 08:21:03 INFO - 'PAGER': '/bin/cat', 08:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:03 INFO - 'PWD': '/builds/slave/test', 08:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:03 INFO - 'SHELL': '/bin/bash', 08:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:21:03 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:03 INFO - 'USER': 'cltbld', 08:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:03 INFO - 'XPC_FLAGS': '0x0', 08:21:03 INFO - 'XPC_SERVICE_NAME': '0', 08:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:03 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-P6JLKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:03 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-1yv0CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:03 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-DRtDQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:03 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tuqk1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:03 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RaYvrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:03 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-_N2mWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0zbcQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-pM7dTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-FGbMoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ns0g0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-S_Nx1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ZssjoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-oBFaoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-vxVOfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-AviRZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:04 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-qZnXk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:05 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-L24K_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:05 INFO - Running setup.py install for manifestparser 08:21:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:05 INFO - Running setup.py install for mozcrash 08:21:05 INFO - Running setup.py install for mozdebug 08:21:05 INFO - Running setup.py install for mozdevice 08:21:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:05 INFO - Running setup.py install for mozfile 08:21:05 INFO - Running setup.py install for mozhttpd 08:21:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Running setup.py install for mozinfo 08:21:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Running setup.py install for mozInstall 08:21:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Running setup.py install for mozleak 08:21:06 INFO - Running setup.py install for mozlog 08:21:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Running setup.py install for moznetwork 08:21:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:06 INFO - Running setup.py install for mozprocess 08:21:06 INFO - Running setup.py install for mozprofile 08:21:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:07 INFO - Running setup.py install for mozrunner 08:21:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:07 INFO - Running setup.py install for mozscreenshot 08:21:07 INFO - Running setup.py install for moztest 08:21:07 INFO - Running setup.py install for mozversion 08:21:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:07 INFO - Cleaning up... 08:21:07 INFO - Return code: 0 08:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:07 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:21:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:07 INFO - 'HOME': '/Users/cltbld', 08:21:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:07 INFO - 'LOGNAME': 'cltbld', 08:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:07 INFO - 'MOZ_NO_REMOTE': '1', 08:21:07 INFO - 'NO_EM_RESTART': '1', 08:21:07 INFO - 'PAGER': '/bin/cat', 08:21:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:07 INFO - 'PWD': '/builds/slave/test', 08:21:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:07 INFO - 'SHELL': '/bin/bash', 08:21:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:21:07 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:21:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:07 INFO - 'USER': 'cltbld', 08:21:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:07 INFO - 'XPC_FLAGS': '0x0', 08:21:07 INFO - 'XPC_SERVICE_NAME': '0', 08:21:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-pTL1aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aiJJ4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:08 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)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-L4v0g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-sGOfNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RbMmsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-pulWZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SVYKR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Waf3X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-zNPm8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:08 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-OK7vhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-bfqQbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-yfP9r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-0YRU0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-_Hxa9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:09 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)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8kw17P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-IOHCY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:09 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-XYqX9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:21:09 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)) 08:21:09 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)) 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:12 INFO - Downloading blessings-1.6.tar.gz 08:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:12 INFO - Installing collected packages: blessings 08:21:12 INFO - Running setup.py install for blessings 08:21:12 INFO - Successfully installed blessings 08:21:12 INFO - Cleaning up... 08:21:12 INFO - Return code: 0 08:21:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:13 INFO - Reading from file tmpfile_stdout 08:21:13 INFO - Current package versions: 08:21:13 INFO - blessings == 1.6 08:21:13 INFO - blobuploader == 1.2.4 08:21:13 INFO - docopt == 0.6.1 08:21:13 INFO - functools32 == 3.2.3-2 08:21:13 INFO - jsonschema == 2.5.1 08:21:13 INFO - manifestparser == 1.1 08:21:13 INFO - mozInstall == 1.12 08:21:13 INFO - mozcrash == 1.0 08:21:13 INFO - mozdebug == 0.1 08:21:13 INFO - mozdevice == 0.48 08:21:13 INFO - mozfile == 1.2 08:21:13 INFO - mozhttpd == 0.7 08:21:13 INFO - mozinfo == 0.9 08:21:13 INFO - mozleak == 0.1 08:21:13 INFO - mozlog == 3.4 08:21:13 INFO - moznetwork == 0.27 08:21:13 INFO - mozprocess == 0.23 08:21:13 INFO - mozprofile == 0.28 08:21:13 INFO - mozrunner == 6.13 08:21:13 INFO - mozscreenshot == 0.1 08:21:13 INFO - mozsystemmonitor == 0.3 08:21:13 INFO - moztest == 0.7 08:21:13 INFO - mozversion == 1.4 08:21:13 INFO - psutil == 3.1.1 08:21:13 INFO - requests == 1.2.3 08:21:13 INFO - wsgiref == 0.1.2 08:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:13 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:21:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:13 INFO - 'HOME': '/Users/cltbld', 08:21:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:13 INFO - 'LOGNAME': 'cltbld', 08:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:13 INFO - 'MOZ_NO_REMOTE': '1', 08:21:13 INFO - 'NO_EM_RESTART': '1', 08:21:13 INFO - 'PAGER': '/bin/cat', 08:21:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:13 INFO - 'PWD': '/builds/slave/test', 08:21:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:13 INFO - 'SHELL': '/bin/bash', 08:21:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:21:13 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:21:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:13 INFO - 'USER': 'cltbld', 08:21:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:13 INFO - 'XPC_FLAGS': '0x0', 08:21:13 INFO - 'XPC_SERVICE_NAME': '0', 08:21:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:14 INFO - Cleaning up... 08:21:14 INFO - Return code: 0 08:21:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:14 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 0x10ff90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabc2db20d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, '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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:14 INFO - 'HOME': '/Users/cltbld', 08:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:14 INFO - 'LOGNAME': 'cltbld', 08:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:14 INFO - 'MOZ_NO_REMOTE': '1', 08:21:14 INFO - 'NO_EM_RESTART': '1', 08:21:14 INFO - 'PAGER': '/bin/cat', 08:21:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:14 INFO - 'PWD': '/builds/slave/test', 08:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:14 INFO - 'SHELL': '/bin/bash', 08:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:21:14 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:14 INFO - 'USER': 'cltbld', 08:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:14 INFO - 'XPC_FLAGS': '0x0', 08:21:14 INFO - 'XPC_SERVICE_NAME': '0', 08:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:14 INFO - Cleaning up... 08:21:14 INFO - Return code: 0 08:21:14 INFO - Running post-action listener: _resource_record_post_action 08:21:14 INFO - Running post-action listener: _start_resource_monitoring 08:21:14 INFO - Starting resource monitoring. 08:21:14 INFO - [mozharness: 2016-11-17 16:21:14.679341Z] Finished create-virtualenv step (success) 08:21:14 INFO - [mozharness: 2016-11-17 16:21:14.680226Z] Running install step. 08:21:14 INFO - Running pre-action listener: _resource_record_pre_action 08:21:14 INFO - Running main action method: install 08:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:14 INFO - Reading from file tmpfile_stdout 08:21:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:15 INFO - Reading from file tmpfile_stdout 08:21:15 INFO - Output received: 08:21:15 INFO - Usage: mozinstall [options] installer 08:21:15 INFO - Options: 08:21:15 INFO - -h, --help show this help message and exit 08:21:15 INFO - -d DEST, --destination=DEST 08:21:15 INFO - Directory to install application into. [default: 08:21:15 INFO - "/builds/slave/test"] 08:21:15 INFO - --app=APP Application being installed. [default: firefox] 08:21:15 INFO - mkdir: /builds/slave/test/build/application 08:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:21:46 INFO - Reading from file tmpfile_stdout 08:21:46 INFO - Output received: 08:21:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:21:46 INFO - Running post-action listener: _resource_record_post_action 08:21:46 INFO - [mozharness: 2016-11-17 16:21:46.973943Z] Finished install step (success) 08:21:46 INFO - [mozharness: 2016-11-17 16:21:46.974082Z] Running run-tests step. 08:21:46 INFO - Running pre-action listener: _resource_record_pre_action 08:21:46 INFO - Running main action method: run_tests 08:21:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:21:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:21:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:21:46 INFO - 2016-11-17 08:21:46.988 screenresolution[1627:7365] starting screenresolution argv=screenresolution get 08:21:46 INFO - 2016-11-17 08:21:46.991 screenresolution[1627:7365] Display 0: 1600x1200x32@60 08:21:46 INFO - 2016-11-17 08:21:46.996 screenresolution[1628:7367] starting screenresolution argv=screenresolution list 08:21:46 INFO - Available Modes on Display 0 08:21:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:21:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:21:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:21:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:21:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:21:47 INFO - Intel Iris: 08:21:47 INFO - Chipset Model: Intel Iris 08:21:47 INFO - Type: GPU 08:21:47 INFO - Bus: Built-In 08:21:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:21:47 INFO - Vendor: Intel (0x8086) 08:21:47 INFO - Device ID: 0x0a2e 08:21:47 INFO - Revision ID: 0x0009 08:21:47 INFO - Displays: 08:21:47 INFO - Display: 08:21:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:21:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:21:47 INFO - Display Serial Number: 1600x1200 60 08:21:47 INFO - Main Display: Yes 08:21:47 INFO - Mirror: Off 08:21:47 INFO - Online: Yes 08:21:47 INFO - Rotation: Supported 08:21:47 INFO - Return code: 0 08:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:47 INFO - Python 2.7.3 08:21:47 INFO - Return code: 0 08:21:47 INFO - grabbing minidump binary from tooltool 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda4d30>, '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 0x10fc0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd9cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:21:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:21:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:21:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:47 INFO - Return code: 0 08:21:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:21:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:21:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2cH8BLVcZM/Render', 08:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:47 INFO - 'HOME': '/Users/cltbld', 08:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:47 INFO - 'LOGNAME': 'cltbld', 08:21:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:47 INFO - 'MOZ_NO_REMOTE': '1', 08:21:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:47 INFO - 'NO_EM_RESTART': '1', 08:21:47 INFO - 'PAGER': '/bin/cat', 08:21:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:47 INFO - 'PWD': '/builds/slave/test', 08:21:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:47 INFO - 'SHELL': '/bin/bash', 08:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xOkZ0u1pPQ/Listeners', 08:21:47 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 08:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:47 INFO - 'USER': 'cltbld', 08:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:47 INFO - 'XPC_FLAGS': '0x0', 08:21:47 INFO - 'XPC_SERVICE_NAME': '0', 08:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:21:47 INFO - mozversion application_buildid: 20161117060328 08:21:47 INFO - mozversion application_changeset: 64936ba0330a72cf5e05bca5f44b84562705fea0 08:21:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:21:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:47 INFO - mozversion application_name: Firefox 08:21:47 INFO - mozversion application_remotingname: firefox-dev 08:21:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:21:47 INFO - mozversion application_vendor: Mozilla 08:21:47 INFO - mozversion application_version: 52.0a2 08:21:47 INFO - mozversion platform_buildid: 20161117060328 08:21:47 INFO - mozversion platform_changeset: 64936ba0330a72cf5e05bca5f44b84562705fea0 08:21:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:21:47 INFO - mozversion platform_version: 52.0a2 08:21:47 INFO - using testdate: 1479399707 08:21:47 INFO - actual date: 1479399707 08:21:47 INFO - starting webserver on 'localhost:49236' 08:21:47 INFO - SUITE-START | Running 2 tests 08:21:47 INFO - TEST-START | dromaeo_css 08:21:47 INFO - operating with platform_type : mac_ 08:21:47 INFO - Initialising browser for dromaeo_css test... 08:21:47 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpLeN83z/profile http://localhost:49236/getInfo.html) 08:21:49 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:21:50 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 08:21:50 INFO - PROCESS | 1638 | colorDepth:24 08:21:50 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 08:21:50 INFO - PROCESS | 1638 | __metrics 08:21:50 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 08:21:51 INFO - TEST-INFO | 1638: exit 0 08:21:51 INFO - Browser initialized. 08:21:51 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:51 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpLeN83z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:03 INFO - PROCESS | 1641 | RSS: Main: 223830016 08:22:03 INFO - PROCESS | 1641 | 08:22:53 INFO - PROCESS | 1641 | 1479399773157 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:25:06 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:25:08 INFO - PROCESS | 1641 | RSS: Main: 233529344 08:25:08 INFO - PROCESS | 1641 | 08:28:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:28:11 INFO - PROCESS | 1641 | RSS: Main: 248066048 08:28:11 INFO - PROCESS | 1641 | 08:31:13 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:31:14 INFO - PROCESS | 1641 | RSS: Main: 251039744 08:31:14 INFO - PROCESS | 1641 | 08:34:16 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:34:16 INFO - PROCESS | 1641 | RSS: Main: 250216448 08:34:16 INFO - PROCESS | 1641 | 08:37:19 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:37:20 INFO - PROCESS | 1641 | RSS: Main: 253607936 08:37:20 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:40:23 INFO - PROCESS | 1641 | RSS: Main: 256122880 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | __start_tp_report 08:40:23 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 08:40:23 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 08:40:23 INFO - PROCESS | 1641 | |i|pagename|runs| 08:40:23 INFO - PROCESS | 1641 | |0;dojo.html;3278.3115545735395;3430.502577126318;3444.070101072712;3465.7920524768515;3505.5618047744033;5879.088741245108;5920.881582368355;5929.555283353744;5945.405459454052;5987.910181347273;5894.292684877821;5972;5974;5991.281046274453;6063.30272018718;5331.546818520421;5376.301080859483;5405.891882162355;5412.269343638617;5441.619086663935;4838.693552740758;4892.877678058059;5416.997855396764;5419.620626556142;5437.184422336662;5299.205119232127;5315.255864179018;5448.536874365664;5455.263539422167;5494.09347457671;4652.906941861161;5096.923546146811;5407.83776486706;5410.864728381783;5418.4039755626845;5170.819021334235;5257.815976440845;5288.8413347599635;5372.785088596452;5463.726813659301;5971.223740913697;5984.581079324449;5988.071848863433;6002.699865006733;6022.879542409128;5281.867953301198;5896.086106653433;6146.709191069881;6308.621482711052;6338.461230795342;6277.780277690259;6282.905756413657;6292.590981586228;6363.618182908994;6367.204099487564;6015.248093988252;6029.487493563052;6075.848103797441;6103.1455596216565;6112.938870611326;4878.780454879539;5076.6192535559985;5590.720463976866;5986.012307969223;6396.501399639463;4999.725015124203;6192.318844927055;6239.937600624026;6293.370662933761;6301.243850737941;5304.549113325334;6269.279032911182;6315.242170939425;6346.650934198663;6358.936410635927;6328;6342.270638876588;6350.936490635127;6354.491640668735;6368.808935731936;5140.7943682253035;6257.342978987232;6264.874702506016;6317.620942743358;6380.617162970237;4925.679830810986;4947.802087916515;4986.551210391082;5021.196608542616;5061.8734531637;4332.978335108367;4527.683062185615;4535.863924082283;4538.659600529973;4574.885627859264;6107.816765497042;6123.846903827351;6136.17161683176;6136.78521251763;6144.907826382608;6243.469305109026;6262.6868656566985;6288.308286088527;6334.968325158345;6351.174347334817;5968.253968253968;6111.19673459643;6113.402420883538;6116.640127388518;6146.832101900624;5422.8373148805595;5475.288212532345;5482.725863706799;5492.835214943479;5503.229547863302;6377.71300291488;6428.742850286029;6501.31736167705;6511.055896895018;6539.901901471577;6232.220972378453;6245.812625621239;6317.652529110943;6371.872562548816;6379.808605741835;5272.86817829542;5318;6451.806445806634;6535.183102112236;6536.346365363425;6317.052442133717;6325.9683701583035;6330.620162790247;6356.809295721136;6388.648624325707;6203.968980155251;6291.496680265476;6335;6343.841403964938;6346.079818426395;5192.948070519246;5841.737121829613;6182.041783523561;6242.406971337716;6250.718717657625;6272.372762723691;6286.717097730521;6302.527310451826;6310.5898116622275;6329.734053189472;6018.789342372996;6055.1220073090035;6182.474489668429;6237.906431403623;6240.188775459162;5166.715830629201;6035.637861728311;6139.032198454696;6175.289841668086;6239.563230573816;6167.383261673796;6193;6225.190725205694;6254.655993920378;6279.372062793684 08:40:23 INFO - PROCESS | 1641 | |1;ext.html;460.3807878403547;468.4448928020295;485.8153901517423;524.5593701290915;547.9725514660013;22035.669464958017;30187.094387168392;40296.19407611846;40415.78752637425;40458.39312410309;41242;41717;41798.955026124284;41837.16325673485;41976;8023.879641805378;9194.080591940803;9347.579358928864;9362.110599493071;9374;7907.090684571262;7915.8416831663335;9171.54142292886;9298.535073246345;9305.25557955362;9210.309226807984;9276.304277179204;9298.349115561914;9315.487648179347;9323.347365684405;7867.252611001945;9180.770480738001;9197.126273004122;9248.121428464285;9334.346595738301;9188.770280742969;9198.448093114435;9270.72187834366;9279.860802087975;9291;34844.82577587096;39841.60158398437;40160.799196004125;40193.39709904354;40255.993600159934;2827.4627820714;3324.517944897976;3431.3480438716565;3496.3531746626954;3563.5367402237803;30012.54981175284;30198;30244;30779.38441231163;30968.535471967938;3098.612673415823;3136.9843150784327;3204.8237346945907;3224.000559826438;3236.886708965175;376329;467995;476754;482731;486753.99999999645;60537.394626053174;60679.089813652834;60886.391136088074;60974.085388719206;61031.38968610346;61039.08441373383;64554.354456454836;64603.70792584122;64838.35161648417;65756;16079.196040197943;16093.839061609468;16251.268692908847;16278.674426511403;16289.592760180853;12505.3747312634;12526.248425094524;12588;12616.747665046647;12659.177153485178;17280.913595431943;17526.474205773848;17758.023308718144;17765.911170444066;17768.555786105193;2427.9028838846602;3265.7387409007224;6749.460043196533;6776.457883369319;6830.658467076626;809.433396622355;854.5513605357237;961.7643677299106;977.5014742481244;1003.7691330993912;22896.198633047763;23052;23113.653295200584;23130.190443334403;23588.05647774104;932.4498545857841;971.8882328532168;993.4734590666958;1023.5445226874118;1107.8615173103362;12670.683232919066;13177.604671859859;13307.800382994263;13336.799948000787;13393.129446585941;611744;617288;617652;617850;619439;58067.12899306514;58434.83130337369;58566.70716646389;58678.706606466694;58935.41064589385;1190.2858285028913;1328.4221363706818;1368.904176707621;1387.4172847404116;1395.1210737235476;22085.006174722497;22404.439889002904;22545.09819607263;22890.31329060131;30874.228144296572;43877.34183987179;54745.72627136839;56724.86550269054;57001.429985699615;57172.71413642905;561226;566094;566278;566500;567999;33091.00726978194;42913.78543107265;42959.14081718286;43160.78419607882;43314;46202;47202.527974719815;47386;47618.52381476141;48439.75780121077;39423.605763941996;39528;39830.2033959325;40268.59731402648;40964.79517602393;33071.50392744063;36403.089922752144;39085.82742517729;39575;40285;37873.43189852099;38685;39148;39150;39262.60737392589;32859.50710739389;35121;35334.29331413409;35474.06706193056;35476;25548.48903021966;25997.350066248495;26230.671939130592;26351.34121646974;26458.338541535846 08:40:23 INFO - PROCESS | 1641 | |2;jquery.html;348.70534398433324;369.0644216910133;381.97135214858884;384.81528866144265;402.1775469165556;18883.055847207637;19233.519162020955;19392.127354269058;19810.99999999998;20057.398278051645;16690.666186676288;16761.413350532734;18524.536886577807;19150.904245478752;19219.135138918748;5268.868278293035;5328.760205790749;5458.781648734046;5540.141278101901;5548.445155484439;5294.100002999499;5476.069068258385;5477.0415177344;5487.847552014082;5497.230387745719;5244.010913779148;5463;5467.125259958408;5476.808311709091;5481.972590137044;5298.284731561228;5488.259085023511;5490.80782172626;5501.972490137564;5508.55931525479;5118.181091025455;5271.86820329491;5349.545288650431;5355.973220133913;5372.086745253317;13200.20798752078;13353.73292534144;20444.795552044437;23823.285301440985;24530.632040519406;2114.0381126587367;2119.8940052997286;2162.36210317955;2300.7124109486313;2384.1893756122827;9922.107010369029;10000.399976001463;10020.348677336022;10419.791604167875;10444.68665940023;1794.7397627343962;1817.391173956726;1850.3153833081847;1877.5024618476116;1924.124523341876;111563;117196;117640;117917.41041294824;118007;9670.75823104414;9810.607575696893;11383.373914434786;11712.535933008374;12128.939355303168;11456.427178641035;14625.195614241318;14847.70304593902;14876;14885.627859303388;8110;8271.379646526535;8363.414560980673;8585.570721463902;8592.183742544448;8234.176582341717;8253.752387428387;8263.628136733862;8358.331333493306;8418.705345312885;3701.370766969622;4444.755538445416;4558.680892337505;4569.428821397325;4595.356650068993;1636.5908522869283;1651.9256633451523;1884.0862181841796;1939.5054261163596;1945.3872030310406;738;849.4011721736161;850.2050582705191;867.150192811036;903.5256490342491;19998.800011999985;20841.166353346;21174.258900938392;21323.78676213249;21350.679739803916;907.7775944893411;913.917747402737;930.3627015494408;961.6345788600427;996.1283876607968;9901.504924753734;10452.693413323335;10672.039516443558;11227.326360418401;11237;521150;523336;566037;584538;587165;108550;109872;111063;112527.87472125338;115609.4219528897;896.121800635381;946.8674385586023;965.1940629574244;988.2439933450772;1009.1170226052204;13038.804417933929;18619.81380186181;19217.039148042262;19334.70997935004;19680.40958771239;49252.75373623109;52248;52685.47314526806;56797.148042778565;56936;63720.68139659458;68959.96560051503;74579;77791.61104194443;80584.59707701424;8018.3184429324165;8018.679252830055;8067.354611630938;8176.550289734122;8428.325733941392;11470;12519.611542509547;12624.548176959766;12711.745765084832;12767.233965962072;10331.656884604954;11031.393273370042;11042.17183711241;11112.666620001413;11147.442627868411;4023.2154729827403;8988.910110898807;10652.295632698731;10793.568257269935;11128.109751220045;10266.486675666038;10585.52365143555;10944.975179591802;11051.502682379472;11141.610043648434;7005.22942476317;7405.555666660018;7436.256374362737;8141.918580814353;8214.83570328602;10092.091711745978;10720.303180293256;10871.728206794576;11165.330080195214;11236.83144752813 08:40:23 INFO - PROCESS | 1641 | |3;mootools.html;1165.1552624347346;1205.42139772909;1376.3806287170773;1749.6413235286768;1800.4688616858025;6526;6531.869362612745;8077.474964127335;8482.557965145925;8621.094785047573;6942;8052;8344.91655083449;8365.874511882326;8489.745307640766;1938.3022112039655;2313.0400883633315;2330.498942727313;2361.645753137026;2366.7751563601514;2352.164981431593;2381.880905954704;2394.4971555973266;2401.7838394544488;2405.9518809623796;2326.9650955235684;2335.369450248432;2344.0623750499853;2365.1603680693365;2370.632551954441;2268.6483595042714;2275.6358982562792;2279.190887235041;2292.1519037956064;2303.9884800576056;2119.7138386317956;2228.019671344603;2351.2828587280874;2371.395294199985;2386.880655967195;7626.8093297668;7843.705788544883;8432.747017589421;8438.915610843875;8515.95742021292;5062.443131255559;5212.009718153538;5214.113600687892;5222.97388513055;5233.398159211702;3314.486254630536;3526.7531272810916;3577.838997245104;3665.065408320888;3690.5940346561856;1005.9748506287328;1044.9425281609508;1049.4752623688155;1059.057438879398;1102.1458369763418;10928.617498387519;10976.506057227363;11051.28166669172;11090.833637495443;11116.721577018585;4125.463689720317;4511.88720281989;4629.513901040342;4714.929276060793;4810.927836082392;7362.300581444754;9515.809683806423;9537.713868583953;9566.13904748576;9571.952140239255;5223.947760522422;5240.292560504283;5250.947490525123;5251.4485978972425;5260.342457192851;4010.9197816043516;4238.406623072772;4562.110388474216;4744.4543877454535;4803.063402636522;3797.8290976906105;3812.1232116613332;3869.3035253654048;3898.2593307271527;3915.2169566086895;1271.8664540223328;1272.401971073594;1274.3182397417338;1292.38611659461;1292.6315999939973;852.3649880838815;857.4512312120248;893.4639216470196;908.1735620585235;917.2616044084442;5070.757664372252;5633.2395126657375;5679.772809087673;5778.88442231153;5937.970310148422;857.5540718826176;924.4453328003144;957.167264479893;963.2919803944095;999.820032394176;3817.770933743984;3828.3300422425964;3852.57621661617;3890.280298144852;3891.9221615568094;8219.917800822035;10227.846582301272;10287.639932602324;10310.278280520442;10320.638777642747;10237.795244095076;10252.58989640406;10272.640457583948;10275.74310642225;10284;7579.1662917079075;7868.685252589832;7931.801704957307;7948.960255198687;8024.679012839421;5891.909996650634;5892.646441213369;5901.144334071621;5959.344472108151;6006.549508786946;9166;9527.47598882068;9544.522773861418;9623.711288661352;9669.178119859891;9427.104425079606;9637.18083962871;9679.177269931854;9810.313278070467;9811.656592019244;7161.4986950912935;7222.674979626035;7227.855442891007;7234.96382518084;7291.08861392326;7698;7720.806979825549;7762.961185194038;7774.92225077742;7790.61046947639;7028.753993610199;7154.534955227893;7216.170140433917;7256.45576581769;7300.817479563053;6017.789377371771;6850.623215723183;6961.303869612998;6984.511084224258;7105.431565474646;6680.098186744727;6683.933160668331;6733.562318449285;6750.3924646782025;6794.116764820739;4796.184648609815;4798.832040878552;4813.711177329372;4840.1529732296;4871.95128048715;4075.836966521306;4863.659543831898;4892.192788189909;4942.061008408391;4992.301077849032 08:40:23 INFO - PROCESS | 1641 | |4;prototype.html;242.9805615550756;244.63305042436346;252.8078660218234;301.60941580653036;314.85831375880855;4542.772861356932;5320.361556613202;5547.22488803583;5566.944330556698;5579.804706835267;4612.815487380501;5172.1380303090955;5236.821715114097;5427.864303392407;5531.419200983899;3269.3788180245797;4176;4183.581641835823;4195.112199510218;4211.936820947688;3798.9240215195678;4064.248114098886;4205.768682722449;4216.725912815673;4229.688796473088;4054.736442131267;4070.5929407059352;4074.22589707956;4080.510338759353;4111.814968326433;3855.20968201518;4064.7561146331313;4081.2041651877894;4083.3466645336903;4136.234796562646;3529.858805647771;3538.9469157962653;3549.1304630365726;3549.8402571884326;3568.2506673598577;4787.521247875219;4854.029194161182;5254.789808407659;5297.980151313753;5339.46605339463;3922.352811786052;4122.876313710593;4214.936775948333;4297.20501707182;4666.603338716213;5683.857903552403;5711.914321285184;5713.542916566665;5717.685527295997;5734.283214598176;3391.745619078579;3512.531999761863;3526.5239192708914;3750.2124553843723;3812.9618703812885;5484.808031718911;5522.337319521643;5859.736311865976;6012.78955236569;6062.666213433082;3637.3089113068963;3942.3692209246383;3955.5253369595835;3984.2828290907914;3991.1219531702977;3336.697678601757;3821.121142137324;3906.531216254011;3971.2923442919823;4086.0602061526015;3818.541774986964;4568.200564901129;4618.699784513996;4645.5354464553275;4665.46347170073;4827.517248275144;4839.274108883696;5746.5402767779315;5796.5072968797285;5860.619059761102;1224.1430998301225;1238.8946939510242;1275.2985857778185;1276.3235485192863;1286.202554416249;807.8707406814881;848.452747977551;869.9478031318141;880.2561835249204;887.689308741948;4260.934766308423;4481.596656300949;5117.181250999822;5150.922736158961;5160.458151894072;4886.188772757255;5276.926302756789;5450.939050407472;5577.179631952125;5602.573966566449;4630.143423466669;4701.623870090384;4800.783964721526;4854.490278520775;5151.407588127413;2539.022476346583;2687.905923292675;2699.879549986773;2791.8185317954676;2845.278606443072;4785;5483.424240454775;5497.560195184456;5762.366139724627;5847.590668653153;5082.797837362438;5248.1163938685095;5292.644773076021;5399.676019438846;5783.893435660644;4431.889202769957;5485.945140548623;5489.968711576742;5758.157389635277;5802.883942321046;4766.571008609242;5370.221317908803;5525.756704741401;5533.944660553343;5572.3034620672415;4698.496481126007;5135.666181698178;5484.808031718871;5502.038532256769;5620.353659329229;4913.901721965469;5181.948180518298;5730.481422422978;5808.420011884531;5909.349971503045;3091.1916528830884;3678.668919797231;3694.3719567673024;3737.841269206555;3738.495303134042;4886.507880980655;5405.216313598421;5489.835304940858;5555.444555444556;5590.6176763057765;4650;5007.47421520735;5360.571154307724;5620.100783874561;5716.999050332351;4880.243562247715;5400.729963501888;5544.918740845496;5870.765169393177;5890.469857712655;5307.513896109095;5492.752826122914;5691.26013618227;5748.626339287933;5755.510781583444;4666.786635474733;5274.3670759509105;5444.856580118061;5828.970855145697;5836.824895253149;4848.684835485682;5764;5765.336986246468;5783.768649253982;5806.44516412777 08:40:23 INFO - PROCESS | 1641 | |5;yui.html;633.6071635585936;700.7057036044864;708.2315687479085;711.4273010226765;743.4127039638686;13761.518346857862;14627.634309142277;14705.044172128817;14740.262986850641;14760.188189649565;13067;13117.803232951514;13171;13183.472661093545;13184.340782960862;645.3901063494999;664.5713514782963;781.0978320040363;788.373243271599;798.5408390175643;785.1834092543747;798.9960050199741;799.0730752327302;800.927916487516;801.1027649033091;826.8304997475533;854.1117238072397;854.9615267312955;855.1619412975257;856.1866227084295;834.8497270491309;843.5191940593834;846.1200351634293;849.3375167369462;852.3905407633509;619.7211254935252;622.8318354044428;633.7971849008319;635.2884769058637;636.4971672378815;13201.14192577489;13294.40175192109;13294.534691285759;13321.600351989457;13386.79919801194;10795.5681772729;13371.598852034358;13382.799258011137;13484;13493.730125397535;10991.890081099167;11095.44522773866;11265.662030139109;11421.828672569918;11615.883841161565;3560.394732895414;3597.3524765542193;3728.0493474163914;3764.7176461765475;3772.4529943158086;59367.70316148435;77672;89553.20893582157;90902.54548727215;95381.52309238478;10126.291159618904;10408.219383546264;10473.895261047444;10532.262741608167;10771.784564308826;16308.347666093461;19935.900320498597;20264.493387665425;20309.984500775197;20389.49026274355;6365.822322870284;7220.638968051681;7323.12122545298;7450.96274518624;7646.9617651911385;4128.91742165161;4201.474815648044;4283.421738065322;4290.141971605692;4317.330813723878;3274.0832566881313;3363.8654453822064;3376.679215474526;3379.915502112467;3386.238096428284;525.3197109742816;625.2902955145851;626.9216347956506;638.0620487882804;642.4795915308615;632.9240491141093;634.8984162533973;635.6885126288086;636.3096040795696;654.214942069509;7611.733589324347;8416.74749757496;8658.653653853775;9228.95385523068;9252.491112988715;577.9364269930304;631.3623240527008;646.2261093298831;661.8279247395711;669.899515072743;3563.6080031196548;4070.9619047142787;4460.3532487789735;4534.841280555164;4643.8374656886845;92910.07089929013;93086.53456732808;93945.5302723482;95563;98773.50613246887;47985.760071199424;57597.712011439675;75448.62275688586;77997;82520.58739706263;75206.24793752102;82766.58616706998;83867;85800.57099714462;91060;9195.954020229856;9874.55564499585;9884.505774711091;9931.404115753077;9968.352057116264;51550;53031.734841325546;53763.73118134384;53863.46136538585;54361;69155.65422172858;74947;75293.62353188418;75477.86783198146;75912.24087759273;12920.935395322964;12922.160059596095;13013.089083764045;13158.21050736959;13204.933975330061;12564.120511564102;13630.863691363356;14644.414223430944;15252.542423727306;15285.388584456941;12630.179038362478;12993;13465.798013029616;13793.034487586174;13796.896248300312;13280.493526458307;13565.728685426433;13626;14035.157890526601;14066.507672231422;12842;13409.32953352348;13424;13426.060175787601;13711.520096796565;10651.680449586525;10657.20070994663;10730.946345268223;11027.669169924915;11367.431628418712;10570;11057.336559806437;11075.501602428072;11131.888681113085;11240.718982025188 08:40:23 INFO - PROCESS | 1641 | __end_tp_report 08:40:23 INFO - PROCESS | 1641 | __start_cc_report 08:40:23 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,366 08:40:23 INFO - PROCESS | 1641 | __end_cc_report 08:40:23 INFO - PROCESS | 1641 | __startTimestamp1479400823325__endTimestamp 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | ------- Summary: start ------- 08:40:23 INFO - PROCESS | 1641 | Number of tests: 6 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5813.48 Median:6107.82 stddev:670.73 (11.0%) stddev-sans-first:642.63 08:40:23 INFO - PROCESS | 1641 | Values: 3278.3 3430.5 3444.1 3465.8 3505.6 5879.1 5920.9 5929.6 5945.4 5987.9 5894.3 5972.0 5974.0 5991.3 6063.3 5331.5 5376.3 5405.9 5412.3 5441.6 4838.7 4892.9 5417.0 5419.6 5437.2 5299.2 5315.3 5448.5 5455.3 5494.1 4652.9 5096.9 5407.8 5410.9 5418.4 5170.8 5257.8 5288.8 5372.8 5463.7 5971.2 5984.6 5988.1 6002.7 6022.9 5281.9 5896.1 6146.7 6308.6 6338.5 6277.8 6282.9 6292.6 6363.6 6367.2 6015.2 6029.5 6075.8 6103.1 6112.9 4878.8 5076.6 5590.7 5986.0 6396.5 4999.7 6192.3 6239.9 6293.4 6301.2 5304.5 6269.3 6315.2 6346.7 6358.9 6328.0 6342.3 6350.9 6354.5 6368.8 5140.8 6257.3 6264.9 6317.6 6380.6 4925.7 4947.8 4986.6 5021.2 5061.9 4333.0 4527.7 4535.9 4538.7 4574.9 6107.8 6123.8 6136.2 6136.8 6144.9 6243.5 6262.7 6288.3 6335.0 6351.2 5968.3 6111.2 6113.4 6116.6 6146.8 5422.8 5475.3 5482.7 5492.8 5503.2 6377.7 6428.7 6501.3 6511.1 6539.9 6232.2 6245.8 6317.7 6371.9 6379.8 5272.9 5318.0 6451.8 6535.2 6536.3 6317.1 6326.0 6330.6 6356.8 6388.6 6204.0 6291.5 6335.0 6343.8 6346.1 5192.9 5841.7 6182.0 6242.4 6250.7 6272.4 6286.7 6302.5 6310.6 6329.7 6018.8 6055.1 6182.5 6237.9 6240.2 5166.7 6035.6 6139.0 6175.3 6239.6 6167.4 6193.0 6225.2 6254.7 6279.4 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:68261.76 Median:40711.59 stddev:147296.03 (361.8%) stddev-sans-first:147621.27 08:40:23 INFO - PROCESS | 1641 | Values: 460.4 468.4 485.8 524.6 548.0 22035.7 30187.1 40296.2 40415.8 40458.4 41242.0 41717.0 41799.0 41837.2 41976.0 8023.9 9194.1 9347.6 9362.1 9374.0 7907.1 7915.8 9171.5 9298.5 9305.3 9210.3 9276.3 9298.3 9315.5 9323.3 7867.3 9180.8 9197.1 9248.1 9334.3 9188.8 9198.4 9270.7 9279.9 9291.0 34844.8 39841.6 40160.8 40193.4 40256.0 2827.5 3324.5 3431.3 3496.4 3563.5 30012.5 30198.0 30244.0 30779.4 30968.5 3098.6 3137.0 3204.8 3224.0 3236.9 376329.0 467995.0 476754.0 482731.0 486754.0 60537.4 60679.1 60886.4 60974.1 61031.4 61039.1 64554.4 64603.7 64838.4 65756.0 16079.2 16093.8 16251.3 16278.7 16289.6 12505.4 12526.2 12588.0 12616.7 12659.2 17280.9 17526.5 17758.0 17765.9 17768.6 2427.9 3265.7 6749.5 6776.5 6830.7 809.4 854.6 961.8 977.5 1003.8 22896.2 23052.0 23113.7 23130.2 23588.1 932.4 971.9 993.5 1023.5 1107.9 12670.7 13177.6 13307.8 13336.8 13393.1 611744.0 617288.0 617652.0 617850.0 619439.0 58067.1 58434.8 58566.7 58678.7 58935.4 1190.3 1328.4 1368.9 1387.4 1395.1 22085.0 22404.4 22545.1 22890.3 30874.2 43877.3 54745.7 56724.9 57001.4 57172.7 561226.0 566094.0 566278.0 566500.0 567999.0 33091.0 42913.8 42959.1 43160.8 43314.0 46202.0 47202.5 47386.0 47618.5 48439.8 39423.6 39528.0 39830.2 40268.6 40964.8 33071.5 36403.1 39085.8 39575.0 40285.0 37873.4 38685.0 39148.0 39150.0 39262.6 32859.5 35121.0 35334.3 35474.1 35476.0 25548.5 25997.4 26230.7 26351.3 26458.3 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:32766.73 Median:358.88 stddev:92985.43 (25909.5%) stddev-sans-first:93214.42 08:40:23 INFO - PROCESS | 1641 | Values: 348.7 369.1 382.0 384.8 402.2 18883.1 19233.5 19392.1 19811.0 20057.4 16690.7 16761.4 18524.5 19150.9 19219.1 5268.9 5328.8 5458.8 5540.1 5548.4 5294.1 5476.1 5477.0 5487.8 5497.2 5244.0 5463.0 5467.1 5476.8 5482.0 5298.3 5488.3 5490.8 5502.0 5508.6 5118.2 5271.9 5349.5 5356.0 5372.1 13200.2 13353.7 20444.8 23823.3 24530.6 2114.0 2119.9 2162.4 2300.7 2384.2 9922.1 10000.4 10020.3 10419.8 10444.7 1794.7 1817.4 1850.3 1877.5 1924.1 111563.0 117196.0 117640.0 117917.4 118007.0 9670.8 9810.6 11383.4 11712.5 12128.9 11456.4 14625.2 14847.7 14876.0 14885.6 8110.0 8271.4 8363.4 8585.6 8592.2 8234.2 8253.8 8263.6 8358.3 8418.7 3701.4 4444.8 4558.7 4569.4 4595.4 1636.6 1651.9 1884.1 1939.5 1945.4 738.0 849.4 850.2 867.2 903.5 19998.8 20841.2 21174.3 21323.8 21350.7 907.8 913.9 930.4 961.6 996.1 9901.5 10452.7 10672.0 11227.3 11237.0 521150.0 523336.0 566037.0 584538.0 587165.0 108550.0 109872.0 111063.0 112527.9 115609.4 896.1 946.9 965.2 988.2 1009.1 13038.8 18619.8 19217.0 19334.7 19680.4 49252.8 52248.0 52685.5 56797.1 56936.0 63720.7 68960.0 74579.0 77791.6 80584.6 8018.3 8018.7 8067.4 8176.6 8428.3 11470.0 12519.6 12624.5 12711.7 12767.2 10331.7 11031.4 11042.2 11112.7 11147.4 4023.2 8988.9 10652.3 10793.6 11128.1 10266.5 10585.5 10945.0 11051.5 11141.6 7005.2 7405.6 7436.3 8141.9 8214.8 10092.1 10720.3 10871.7 11165.3 11236.8 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5442.34 Median:5141.38 stddev:2987.14 (58.1%) stddev-sans-first:2978.22 08:40:23 INFO - PROCESS | 1641 | Values: 1165.2 1205.4 1376.4 1749.6 1800.5 6526.0 6531.9 8077.5 8482.6 8621.1 6942.0 8052.0 8344.9 8365.9 8489.7 1938.3 2313.0 2330.5 2361.6 2366.8 2352.2 2381.9 2394.5 2401.8 2406.0 2327.0 2335.4 2344.1 2365.2 2370.6 2268.6 2275.6 2279.2 2292.2 2304.0 2119.7 2228.0 2351.3 2371.4 2386.9 7626.8 7843.7 8432.7 8438.9 8516.0 5062.4 5212.0 5214.1 5223.0 5233.4 3314.5 3526.8 3577.8 3665.1 3690.6 1006.0 1044.9 1049.5 1059.1 1102.1 10928.6 10976.5 11051.3 11090.8 11116.7 4125.5 4511.9 4629.5 4714.9 4810.9 7362.3 9515.8 9537.7 9566.1 9572.0 5223.9 5240.3 5250.9 5251.4 5260.3 4010.9 4238.4 4562.1 4744.5 4803.1 3797.8 3812.1 3869.3 3898.3 3915.2 1271.9 1272.4 1274.3 1292.4 1292.6 852.4 857.5 893.5 908.2 917.3 5070.8 5633.2 5679.8 5778.9 5938.0 857.6 924.4 957.2 963.3 999.8 3817.8 3828.3 3852.6 3890.3 3891.9 8219.9 10227.8 10287.6 10310.3 10320.6 10237.8 10252.6 10272.6 10275.7 10284.0 7579.2 7868.7 7931.8 7949.0 8024.7 5891.9 5892.6 5901.1 5959.3 6006.5 9166.0 9527.5 9544.5 9623.7 9669.2 9427.1 9637.2 9679.2 9810.3 9811.7 7161.5 7222.7 7227.9 7235.0 7291.1 7698.0 7720.8 7763.0 7774.9 7790.6 7028.8 7154.5 7216.2 7256.5 7300.8 6017.8 6850.6 6961.3 6984.5 7105.4 6680.1 6683.9 6733.6 6750.4 6794.1 4796.2 4798.8 4813.7 4840.2 4872.0 4075.8 4863.7 4892.2 4942.1 4992.3 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4478.14 Median:4886.35 stddev:1386.86 (28.4%) stddev-sans-first:1353.83 08:40:23 INFO - PROCESS | 1641 | Values: 243.0 244.6 252.8 301.6 314.9 4542.8 5320.4 5547.2 5566.9 5579.8 4612.8 5172.1 5236.8 5427.9 5531.4 3269.4 4176.0 4183.6 4195.1 4211.9 3798.9 4064.2 4205.8 4216.7 4229.7 4054.7 4070.6 4074.2 4080.5 4111.8 3855.2 4064.8 4081.2 4083.3 4136.2 3529.9 3538.9 3549.1 3549.8 3568.3 4787.5 4854.0 5254.8 5298.0 5339.5 3922.4 4122.9 4214.9 4297.2 4666.6 5683.9 5711.9 5713.5 5717.7 5734.3 3391.7 3512.5 3526.5 3750.2 3813.0 5484.8 5522.3 5859.7 6012.8 6062.7 3637.3 3942.4 3955.5 3984.3 3991.1 3336.7 3821.1 3906.5 3971.3 4086.1 3818.5 4568.2 4618.7 4645.5 4665.5 4827.5 4839.3 5746.5 5796.5 5860.6 1224.1 1238.9 1275.3 1276.3 1286.2 807.9 848.5 869.9 880.3 887.7 4260.9 4481.6 5117.2 5150.9 5160.5 4886.2 5276.9 5450.9 5577.2 5602.6 4630.1 4701.6 4800.8 4854.5 5151.4 2539.0 2687.9 2699.9 2791.8 2845.3 4785.0 5483.4 5497.6 5762.4 5847.6 5082.8 5248.1 5292.6 5399.7 5783.9 4431.9 5485.9 5490.0 5758.2 5802.9 4766.6 5370.2 5525.8 5533.9 5572.3 4698.5 5135.7 5484.8 5502.0 5620.4 4913.9 5181.9 5730.5 5808.4 5909.3 3091.2 3678.7 3694.4 3737.8 3738.5 4886.5 5405.2 5489.8 5555.4 5590.6 4650.0 5007.5 5360.6 5620.1 5717.0 4880.2 5400.7 5544.9 5870.8 5890.5 5307.5 5492.8 5691.3 5748.6 5755.5 4666.8 5274.4 5444.9 5829.0 5836.8 4848.7 5764.0 5765.3 5783.8 5806.4 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19145.23 Median:49767.88 stddev:26854.22 (54.0%) stddev-sans-first:26893.58 08:40:23 INFO - PROCESS | 1641 | Values: 633.6 700.7 708.2 711.4 743.4 13761.5 14627.6 14705.0 14740.3 14760.2 13067.0 13117.8 13171.0 13183.5 13184.3 645.4 664.6 781.1 788.4 798.5 785.2 799.0 799.1 800.9 801.1 826.8 854.1 855.0 855.2 856.2 834.8 843.5 846.1 849.3 852.4 619.7 622.8 633.8 635.3 636.5 13201.1 13294.4 13294.5 13321.6 13386.8 10795.6 13371.6 13382.8 13484.0 13493.7 10991.9 11095.4 11265.7 11421.8 11615.9 3560.4 3597.4 3728.0 3764.7 3772.5 59367.7 77672.0 89553.2 90902.5 95381.5 10126.3 10408.2 10473.9 10532.3 10771.8 16308.3 19935.9 20264.5 20310.0 20389.5 6365.8 7220.6 7323.1 7451.0 7647.0 4128.9 4201.5 4283.4 4290.1 4317.3 3274.1 3363.9 3376.7 3379.9 3386.2 525.3 625.3 626.9 638.1 642.5 632.9 634.9 635.7 636.3 654.2 7611.7 8416.7 8658.7 9229.0 9252.5 577.9 631.4 646.2 661.8 669.9 3563.6 4071.0 4460.4 4534.8 4643.8 92910.1 93086.5 93945.5 95563.0 98773.5 47985.8 57597.7 75448.6 77997.0 82520.6 75206.2 82766.6 83867.0 85800.6 91060.0 9196.0 9874.6 9884.5 9931.4 9968.4 51550.0 53031.7 53763.7 53863.5 54361.0 69155.7 74947.0 75293.6 75477.9 75912.2 12920.9 12922.2 13013.1 13158.2 13204.9 12564.1 13630.9 14644.4 15252.5 15285.4 12630.2 12993.0 13465.8 13793.0 13796.9 13280.5 13565.7 13626.0 14035.2 14066.5 12842.0 13409.3 13424.0 13426.1 13711.5 10651.7 10657.2 10730.9 11027.7 11367.4 10570.0 11057.3 11075.5 11131.9 11240.7 08:40:23 INFO - PROCESS | 1641 | -------- Summary: end -------- 08:40:23 INFO - PROCESS | 1641 | 08:40:23 INFO - TEST-INFO | 1641: exit 0 08:40:23 INFO - TEST-OK | dromaeo_css | took 1116358ms 08:40:23 INFO - TEST-START | kraken 08:40:23 INFO - operating with platform_type : mac_ 08:40:23 INFO - Initialising browser for kraken test... 08:40:23 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp5UWfhU/profile http://localhost:49236/getInfo.html) 08:40:25 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:40:26 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 08:40:26 INFO - PROCESS | 1653 | colorDepth:24 08:40:26 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 08:40:26 INFO - PROCESS | 1653 | __metrics 08:40:26 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 08:40:27 INFO - TEST-INFO | 1653: exit 0 08:40:27 INFO - Browser initialized. 08:40:27 INFO - Running cycle 1/1 for kraken test... 08:40:27 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp5UWfhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:39 INFO - PROCESS | 1655 | RSS: Main: 224370688 08:40:39 INFO - PROCESS | 1655 | 08:40:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:43 INFO - PROCESS | 1655 | RSS: Main: 236437504 08:40:43 INFO - PROCESS | 1655 | 08:40:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:40:46 INFO - PROCESS | 1655 | RSS: Main: 244072448 08:40:46 INFO - PROCESS | 1655 | 08:40:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:40:50 INFO - PROCESS | 1655 | RSS: Main: 247947264 08:40:50 INFO - PROCESS | 1655 | 08:40:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:40:53 INFO - PROCESS | 1655 | RSS: Main: 248180736 08:40:53 INFO - PROCESS | 1655 | 08:40:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:55 INFO - PROCESS | 1655 | RSS: Main: 249466880 08:40:55 INFO - PROCESS | 1655 | 08:40:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:59 INFO - PROCESS | 1655 | RSS: Main: 253366272 08:40:59 INFO - PROCESS | 1655 | 08:41:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:02 INFO - PROCESS | 1655 | RSS: Main: 253554688 08:41:02 INFO - PROCESS | 1655 | 08:41:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:41:06 INFO - PROCESS | 1655 | RSS: Main: 252928000 08:41:06 INFO - PROCESS | 1655 | 08:41:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:08 INFO - PROCESS | 1655 | RSS: Main: 252088320 08:41:08 INFO - PROCESS | 1655 | 08:41:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:11 INFO - PROCESS | 1655 | RSS: Main: 252317696 08:41:11 INFO - PROCESS | 1655 | 08:41:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:13 INFO - PROCESS | 1655 | RSS: Main: 252063744 08:41:13 INFO - PROCESS | 1655 | 08:41:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:17 INFO - PROCESS | 1655 | RSS: Main: 252366848 08:41:17 INFO - PROCESS | 1655 | 08:41:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:21 INFO - PROCESS | 1655 | RSS: Main: 252469248 08:41:21 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:41:23 INFO - PROCESS | 1655 | RSS: Main: 253935616 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | __start_tp_report 08:41:23 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 08:41:23 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 08:41:23 INFO - PROCESS | 1655 | |i|pagename|runs| 08:41:23 INFO - PROCESS | 1655 | |0;ai-astar;107;133;176;121;121;159;167;121;120;120 08:41:23 INFO - PROCESS | 1655 | |1;audio-beat-detection;147;124;150;176;133;115;117;120;141;115 08:41:23 INFO - PROCESS | 1655 | |2;audio-dft;201;226;223;200;197;200;198;195;198;196 08:41:23 INFO - PROCESS | 1655 | |3;audio-fft;83;59;56;83;59;61;60;59;79;59 08:41:23 INFO - PROCESS | 1655 | |4;audio-oscillator;86;71;91;74;70;73;88;88;102;123 08:41:23 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;138;86;98;87;89;86;123;132;88;87 08:41:23 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;96;96;95;97;100;154;121;95;94 08:41:23 INFO - PROCESS | 1655 | |7;imaging-desaturate;85;91;88;86;90;88;91;91;90;89 08:41:23 INFO - PROCESS | 1655 | |8;json-parse-financial;57;55;55;57;56;58;59;59;59;59 08:41:23 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;73;72;71;82;103;103;105;75;71;71 08:41:23 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;87;84;82;86;84;84;86;85;88;86 08:41:23 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;158;163;147;147;150;196;168;170;198;289 08:41:23 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;171;182;212;170;167;171;169;229;201;168 08:41:23 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;70;88;92;66;61;87;89;88;89 08:41:23 INFO - PROCESS | 1655 | __end_tp_report 08:41:23 INFO - PROCESS | 1655 | __start_cc_report 08:41:23 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,984 08:41:23 INFO - PROCESS | 1655 | __end_cc_report 08:41:23 INFO - PROCESS | 1655 | __startTimestamp1479400883635__endTimestamp 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | ------- Summary: start ------- 08:41:23 INFO - PROCESS | 1655 | Number of tests: 14 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:134.50 Median:127.00 stddev:23.82 (18.8%) stddev-sans-first:23.09 08:41:23 INFO - PROCESS | 1655 | Values: 107.0 133.0 176.0 121.0 121.0 159.0 167.0 121.0 120.0 120.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:137.00 stddev:19.85 (14.5%) stddev-sans-first:20.47 08:41:23 INFO - PROCESS | 1655 | Values: 147.0 124.0 150.0 176.0 133.0 115.0 117.0 120.0 141.0 115.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:203.40 Median:200.00 stddev:11.30 (5.6%) stddev-sans-first:11.95 08:41:23 INFO - PROCESS | 1655 | Values: 201.0 226.0 223.0 200.0 197.0 200.0 198.0 195.0 198.0 196.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.07 (18.3%) stddev-sans-first:9.84 08:41:23 INFO - PROCESS | 1655 | Values: 83.0 59.0 56.0 83.0 59.0 61.0 60.0 59.0 79.0 59.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:80.00 stddev:16.49 (20.6%) stddev-sans-first:17.49 08:41:23 INFO - PROCESS | 1655 | Values: 86.0 71.0 91.0 74.0 70.0 73.0 88.0 88.0 102.0 123.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:87.00 stddev:21.02 (24.2%) stddev-sans-first:17.64 08:41:23 INFO - PROCESS | 1655 | Values: 138.0 86.0 98.0 87.0 89.0 86.0 123.0 132.0 88.0 87.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:95.00 stddev:19.22 (20.2%) stddev-sans-first:20.09 08:41:23 INFO - PROCESS | 1655 | Values: 95.0 96.0 96.0 95.0 97.0 100.0 154.0 121.0 95.0 94.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:88.90 Median:90.00 stddev:2.13 (2.4%) stddev-sans-first:1.73 08:41:23 INFO - PROCESS | 1655 | Values: 85.0 91.0 88.0 86.0 90.0 88.0 91.0 91.0 90.0 89.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.50 stddev:1.65 (2.8%) stddev-sans-first:1.74 08:41:23 INFO - PROCESS | 1655 | Values: 57.0 55.0 55.0 57.0 56.0 58.0 59.0 59.0 59.0 59.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:71.50 stddev:14.91 (20.9%) stddev-sans-first:15.40 08:41:23 INFO - PROCESS | 1655 | Values: 73.0 72.0 71.0 82.0 103.0 103.0 105.0 75.0 71.0 71.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:1.75 (2.0%) stddev-sans-first:1.73 08:41:23 INFO - PROCESS | 1655 | Values: 87.0 84.0 82.0 86.0 84.0 84.0 86.0 85.0 88.0 86.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:178.60 Median:169.00 stddev:42.86 (25.4%) stddev-sans-first:44.81 08:41:23 INFO - PROCESS | 1655 | Values: 158.0 163.0 147.0 147.0 150.0 196.0 168.0 170.0 198.0 289.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:176.50 stddev:22.13 (12.5%) stddev-sans-first:22.96 08:41:23 INFO - PROCESS | 1655 | Values: 171.0 182.0 212.0 170.0 167.0 171.0 169.0 229.0 201.0 168.0 08:41:23 INFO - PROCESS | 1655 | 08:41:23 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:88.00 stddev:12.06 (13.7%) stddev-sans-first:11.88 08:41:23 INFO - PROCESS | 1655 | Values: 67.0 70.0 88.0 92.0 66.0 61.0 87.0 89.0 88.0 89.0 08:41:23 INFO - PROCESS | 1655 | -------- Summary: end -------- 08:41:23 INFO - PROCESS | 1655 | 08:41:24 INFO - TEST-INFO | 1655: exit 0 08:41:24 INFO - TEST-OK | kraken | took 60531ms 08:41:24 INFO - SUITE-END | took 1176s 08:41:24 INFO - Completed test suite (00:19:37) 08:41:24 INFO - javascript benchmark 08:41:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7099.37515448793, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.3115545735395, 3430.502577126318, 3444.070101072712, 3465.7920524768515, 3505.5618047744033, 5879.088741245108, 5920.881582368355, 5929.555283353744, 5945.405459454052, 5987.910181347273, 5894.292684877821, 5972.0, 5974.0, 5991.281046274453, 6063.30272018718, 5331.546818520421, 5376.301080859483, 5405.891882162355, 5412.269343638617, 5441.619086663935, 4838.693552740758, 4892.877678058059, 5416.997855396764, 5419.620626556142, 5437.184422336662, 5299.205119232127, 5315.255864179018, 5448.536874365664, 5455.263539422167, 5494.09347457671, 4652.906941861161, 5096.923546146811, 5407.83776486706, 5410.864728381783, 5418.4039755626845, 5170.819021334235, 5257.815976440845, 5288.8413347599635, 5372.785088596452, 5463.726813659301, 5971.223740913697, 5984.581079324449, 5988.071848863433, 6002.699865006733, 6022.879542409128, 5281.867953301198, 5896.086106653433, 6146.709191069881, 6308.621482711052, 6338.461230795342, 6277.780277690259, 6282.905756413657, 6292.590981586228, 6363.618182908994, 6367.204099487564, 6015.248093988252, 6029.487493563052, 6075.848103797441, 6103.1455596216565, 6112.938870611326, 4878.780454879539, 5076.6192535559985, 5590.720463976866, 5986.012307969223, 6396.501399639463, 4999.725015124203, 6192.318844927055, 6239.937600624026, 6293.370662933761, 6301.243850737941, 5304.549113325334, 6269.279032911182, 6315.242170939425, 6346.650934198663, 6358.936410635927, 6328.0, 6342.270638876588, 6350.936490635127, 6354.491640668735, 6368.808935731936, 5140.7943682253035, 6257.342978987232, 6264.874702506016, 6317.620942743358, 6380.617162970237, 4925.679830810986, 4947.802087916515, 4986.551210391082, 5021.196608542616, 5061.8734531637, 4332.978335108367, 4527.683062185615, 4535.863924082283, 4538.659600529973, 4574.885627859264, 6107.816765497042, 6123.846903827351, 6136.17161683176, 6136.78521251763, 6144.907826382608, 6243.469305109026, 6262.6868656566985, 6288.308286088527, 6334.968325158345, 6351.174347334817, 5968.253968253968, 6111.19673459643, 6113.402420883538, 6116.640127388518, 6146.832101900624, 5422.8373148805595, 5475.288212532345, 5482.725863706799, 5492.835214943479, 5503.229547863302, 6377.71300291488, 6428.742850286029, 6501.31736167705, 6511.055896895018, 6539.901901471577, 6232.220972378453, 6245.812625621239, 6317.652529110943, 6371.872562548816, 6379.808605741835, 5272.86817829542, 5318.0, 6451.806445806634, 6535.183102112236, 6536.346365363425, 6317.052442133717, 6325.9683701583035, 6330.620162790247, 6356.809295721136, 6388.648624325707, 6203.968980155251, 6291.496680265476, 6335.0, 6343.841403964938, 6346.079818426395, 5192.948070519246, 5841.737121829613, 6182.041783523561, 6242.406971337716, 6250.718717657625, 6272.372762723691, 6286.717097730521, 6302.527310451826, 6310.5898116622275, 6329.734053189472, 6018.789342372996, 6055.1220073090035, 6182.474489668429, 6237.906431403623, 6240.188775459162, 5166.715830629201, 6035.637861728311, 6139.032198454696, 6175.289841668086, 6239.563230573816, 6167.383261673796, 6193.0, 6225.190725205694, 6254.655993920378, 6279.372062793684], "value": 5773.612636230968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.3807878403547, 468.4448928020295, 485.8153901517423, 524.5593701290915, 547.9725514660013, 22035.669464958017, 30187.094387168392, 40296.19407611846, 40415.78752637425, 40458.39312410309, 41242.0, 41717.0, 41798.955026124284, 41837.16325673485, 41976.0, 8023.879641805378, 9194.080591940803, 9347.579358928864, 9362.110599493071, 9374.0, 7907.090684571262, 7915.8416831663335, 9171.54142292886, 9298.535073246345, 9305.25557955362, 9210.309226807984, 9276.304277179204, 9298.349115561914, 9315.487648179347, 9323.347365684405, 7867.252611001945, 9180.770480738001, 9197.126273004122, 9248.121428464285, 9334.346595738301, 9188.770280742969, 9198.448093114435, 9270.72187834366, 9279.860802087975, 9291.0, 34844.82577587096, 39841.60158398437, 40160.799196004125, 40193.39709904354, 40255.993600159934, 2827.4627820714, 3324.517944897976, 3431.3480438716565, 3496.3531746626954, 3563.5367402237803, 30012.54981175284, 30198.0, 30244.0, 30779.38441231163, 30968.535471967938, 3098.612673415823, 3136.9843150784327, 3204.8237346945907, 3224.000559826438, 3236.886708965175, 376329.0, 467995.0, 476754.0, 482731.0, 486753.99999999645, 60537.394626053174, 60679.089813652834, 60886.391136088074, 60974.085388719206, 61031.38968610346, 61039.08441373383, 64554.354456454836, 64603.70792584122, 64838.35161648417, 65756.0, 16079.196040197943, 16093.839061609468, 16251.268692908847, 16278.674426511403, 16289.592760180853, 12505.3747312634, 12526.248425094524, 12588.0, 12616.747665046647, 12659.177153485178, 17280.913595431943, 17526.474205773848, 17758.023308718144, 17765.911170444066, 17768.555786105193, 2427.9028838846602, 3265.7387409007224, 6749.460043196533, 6776.457883369319, 6830.658467076626, 809.433396622355, 854.5513605357237, 961.7643677299106, 977.5014742481244, 1003.7691330993912, 22896.198633047763, 23052.0, 23113.653295200584, 23130.190443334403, 23588.05647774104, 932.4498545857841, 971.8882328532168, 993.4734590666958, 1023.5445226874118, 1107.8615173103362, 12670.683232919066, 13177.604671859859, 13307.800382994263, 13336.799948000787, 13393.129446585941, 611744.0, 617288.0, 617652.0, 617850.0, 619439.0, 58067.12899306514, 58434.83130337369, 58566.70716646389, 58678.706606466694, 58935.41064589385, 1190.2858285028913, 1328.4221363706818, 1368.904176707621, 1387.4172847404116, 1395.1210737235476, 22085.006174722497, 22404.439889002904, 22545.09819607263, 22890.31329060131, 30874.228144296572, 43877.34183987179, 54745.72627136839, 56724.86550269054, 57001.429985699615, 57172.71413642905, 561226.0, 566094.0, 566278.0, 566500.0, 567999.0, 33091.00726978194, 42913.78543107265, 42959.14081718286, 43160.78419607882, 43314.0, 46202.0, 47202.527974719815, 47386.0, 47618.52381476141, 48439.75780121077, 39423.605763941996, 39528.0, 39830.2033959325, 40268.59731402648, 40964.79517602393, 33071.50392744063, 36403.089922752144, 39085.82742517729, 39575.0, 40285.0, 37873.43189852099, 38685.0, 39148.0, 39150.0, 39262.60737392589, 32859.50710739389, 35121.0, 35334.29331413409, 35474.06706193056, 35476.0, 25548.48903021966, 25997.350066248495, 26230.671939130592, 26351.34121646974, 26458.338541535846], "value": 19305.536861721695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.70534398433324, 369.0644216910133, 381.97135214858884, 384.81528866144265, 402.1775469165556, 18883.055847207637, 19233.519162020955, 19392.127354269058, 19810.99999999998, 20057.398278051645, 16690.666186676288, 16761.413350532734, 18524.536886577807, 19150.904245478752, 19219.135138918748, 5268.868278293035, 5328.760205790749, 5458.781648734046, 5540.141278101901, 5548.445155484439, 5294.100002999499, 5476.069068258385, 5477.0415177344, 5487.847552014082, 5497.230387745719, 5244.010913779148, 5463.0, 5467.125259958408, 5476.808311709091, 5481.972590137044, 5298.284731561228, 5488.259085023511, 5490.80782172626, 5501.972490137564, 5508.55931525479, 5118.181091025455, 5271.86820329491, 5349.545288650431, 5355.973220133913, 5372.086745253317, 13200.20798752078, 13353.73292534144, 20444.795552044437, 23823.285301440985, 24530.632040519406, 2114.0381126587367, 2119.8940052997286, 2162.36210317955, 2300.7124109486313, 2384.1893756122827, 9922.107010369029, 10000.399976001463, 10020.348677336022, 10419.791604167875, 10444.68665940023, 1794.7397627343962, 1817.391173956726, 1850.3153833081847, 1877.5024618476116, 1924.124523341876, 111563.0, 117196.0, 117640.0, 117917.41041294824, 118007.0, 9670.75823104414, 9810.607575696893, 11383.373914434786, 11712.535933008374, 12128.939355303168, 11456.427178641035, 14625.195614241318, 14847.70304593902, 14876.0, 14885.627859303388, 8110.0, 8271.379646526535, 8363.414560980673, 8585.570721463902, 8592.183742544448, 8234.176582341717, 8253.752387428387, 8263.628136733862, 8358.331333493306, 8418.705345312885, 3701.370766969622, 4444.755538445416, 4558.680892337505, 4569.428821397325, 4595.356650068993, 1636.5908522869283, 1651.9256633451523, 1884.0862181841796, 1939.5054261163596, 1945.3872030310406, 738.0, 849.4011721736161, 850.2050582705191, 867.150192811036, 903.5256490342491, 19998.800011999985, 20841.166353346, 21174.258900938392, 21323.78676213249, 21350.679739803916, 907.7775944893411, 913.917747402737, 930.3627015494408, 961.6345788600427, 996.1283876607968, 9901.504924753734, 10452.693413323335, 10672.039516443558, 11227.326360418401, 11237.0, 521150.0, 523336.0, 566037.0, 584538.0, 587165.0, 108550.0, 109872.0, 111063.0, 112527.87472125338, 115609.4219528897, 896.121800635381, 946.8674385586023, 965.1940629574244, 988.2439933450772, 1009.1170226052204, 13038.804417933929, 18619.81380186181, 19217.039148042262, 19334.70997935004, 19680.40958771239, 49252.75373623109, 52248.0, 52685.47314526806, 56797.148042778565, 56936.0, 63720.68139659458, 68959.96560051503, 74579.0, 77791.61104194443, 80584.59707701424, 8018.3184429324165, 8018.679252830055, 8067.354611630938, 8176.550289734122, 8428.325733941392, 11470.0, 12519.611542509547, 12624.548176959766, 12711.745765084832, 12767.233965962072, 10331.656884604954, 11031.393273370042, 11042.17183711241, 11112.666620001413, 11147.442627868411, 4023.2154729827403, 8988.910110898807, 10652.295632698731, 10793.568257269935, 11128.109751220045, 10266.486675666038, 10585.52365143555, 10944.975179591802, 11051.502682379472, 11141.610043648434, 7005.22942476317, 7405.555666660018, 7436.256374362737, 8141.918580814353, 8214.83570328602, 10092.091711745978, 10720.303180293256, 10871.728206794576, 11165.330080195214, 11236.83144752813], "value": 9095.074720959465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1165.1552624347346, 1205.42139772909, 1376.3806287170773, 1749.6413235286768, 1800.4688616858025, 6526.0, 6531.869362612745, 8077.474964127335, 8482.557965145925, 8621.094785047573, 6942.0, 8052.0, 8344.91655083449, 8365.874511882326, 8489.745307640766, 1938.3022112039655, 2313.0400883633315, 2330.498942727313, 2361.645753137026, 2366.7751563601514, 2352.164981431593, 2381.880905954704, 2394.4971555973266, 2401.7838394544488, 2405.9518809623796, 2326.9650955235684, 2335.369450248432, 2344.0623750499853, 2365.1603680693365, 2370.632551954441, 2268.6483595042714, 2275.6358982562792, 2279.190887235041, 2292.1519037956064, 2303.9884800576056, 2119.7138386317956, 2228.019671344603, 2351.2828587280874, 2371.395294199985, 2386.880655967195, 7626.8093297668, 7843.705788544883, 8432.747017589421, 8438.915610843875, 8515.95742021292, 5062.443131255559, 5212.009718153538, 5214.113600687892, 5222.97388513055, 5233.398159211702, 3314.486254630536, 3526.7531272810916, 3577.838997245104, 3665.065408320888, 3690.5940346561856, 1005.9748506287328, 1044.9425281609508, 1049.4752623688155, 1059.057438879398, 1102.1458369763418, 10928.617498387519, 10976.506057227363, 11051.28166669172, 11090.833637495443, 11116.721577018585, 4125.463689720317, 4511.88720281989, 4629.513901040342, 4714.929276060793, 4810.927836082392, 7362.300581444754, 9515.809683806423, 9537.713868583953, 9566.13904748576, 9571.952140239255, 5223.947760522422, 5240.292560504283, 5250.947490525123, 5251.4485978972425, 5260.342457192851, 4010.9197816043516, 4238.406623072772, 4562.110388474216, 4744.4543877454535, 4803.063402636522, 3797.8290976906105, 3812.1232116613332, 3869.3035253654048, 3898.2593307271527, 3915.2169566086895, 1271.8664540223328, 1272.401971073594, 1274.3182397417338, 1292.38611659461, 1292.6315999939973, 852.3649880838815, 857.4512312120248, 893.4639216470196, 908.1735620585235, 917.2616044084442, 5070.757664372252, 5633.2395126657375, 5679.772809087673, 5778.88442231153, 5937.970310148422, 857.5540718826176, 924.4453328003144, 957.167264479893, 963.2919803944095, 999.820032394176, 3817.770933743984, 3828.3300422425964, 3852.57621661617, 3890.280298144852, 3891.9221615568094, 8219.917800822035, 10227.846582301272, 10287.639932602324, 10310.278280520442, 10320.638777642747, 10237.795244095076, 10252.58989640406, 10272.640457583948, 10275.74310642225, 10284.0, 7579.1662917079075, 7868.685252589832, 7931.801704957307, 7948.960255198687, 8024.679012839421, 5891.909996650634, 5892.646441213369, 5901.144334071621, 5959.344472108151, 6006.549508786946, 9166.0, 9527.47598882068, 9544.522773861418, 9623.711288661352, 9669.178119859891, 9427.104425079606, 9637.18083962871, 9679.177269931854, 9810.313278070467, 9811.656592019244, 7161.4986950912935, 7222.674979626035, 7227.855442891007, 7234.96382518084, 7291.08861392326, 7698.0, 7720.806979825549, 7762.961185194038, 7774.92225077742, 7790.61046947639, 7028.753993610199, 7154.534955227893, 7216.170140433917, 7256.45576581769, 7300.817479563053, 6017.789377371771, 6850.623215723183, 6961.303869612998, 6984.511084224258, 7105.431565474646, 6680.098186744727, 6683.933160668331, 6733.562318449285, 6750.3924646782025, 6794.116764820739, 4796.184648609815, 4798.832040878552, 4813.711177329372, 4840.1529732296, 4871.95128048715, 4075.836966521306, 4863.659543831898, 4892.192788189909, 4942.061008408391, 4992.301077849032], "value": 4416.150394486831, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [242.9805615550756, 244.63305042436346, 252.8078660218234, 301.60941580653036, 314.85831375880855, 4542.772861356932, 5320.361556613202, 5547.22488803583, 5566.944330556698, 5579.804706835267, 4612.815487380501, 5172.1380303090955, 5236.821715114097, 5427.864303392407, 5531.419200983899, 3269.3788180245797, 4176.0, 4183.581641835823, 4195.112199510218, 4211.936820947688, 3798.9240215195678, 4064.248114098886, 4205.768682722449, 4216.725912815673, 4229.688796473088, 4054.736442131267, 4070.5929407059352, 4074.22589707956, 4080.510338759353, 4111.814968326433, 3855.20968201518, 4064.7561146331313, 4081.2041651877894, 4083.3466645336903, 4136.234796562646, 3529.858805647771, 3538.9469157962653, 3549.1304630365726, 3549.8402571884326, 3568.2506673598577, 4787.521247875219, 4854.029194161182, 5254.789808407659, 5297.980151313753, 5339.46605339463, 3922.352811786052, 4122.876313710593, 4214.936775948333, 4297.20501707182, 4666.603338716213, 5683.857903552403, 5711.914321285184, 5713.542916566665, 5717.685527295997, 5734.283214598176, 3391.745619078579, 3512.531999761863, 3526.5239192708914, 3750.2124553843723, 3812.9618703812885, 5484.808031718911, 5522.337319521643, 5859.736311865976, 6012.78955236569, 6062.666213433082, 3637.3089113068963, 3942.3692209246383, 3955.5253369595835, 3984.2828290907914, 3991.1219531702977, 3336.697678601757, 3821.121142137324, 3906.531216254011, 3971.2923442919823, 4086.0602061526015, 3818.541774986964, 4568.200564901129, 4618.699784513996, 4645.5354464553275, 4665.46347170073, 4827.517248275144, 4839.274108883696, 5746.5402767779315, 5796.5072968797285, 5860.619059761102, 1224.1430998301225, 1238.8946939510242, 1275.2985857778185, 1276.3235485192863, 1286.202554416249, 807.8707406814881, 848.452747977551, 869.9478031318141, 880.2561835249204, 887.689308741948, 4260.934766308423, 4481.596656300949, 5117.181250999822, 5150.922736158961, 5160.458151894072, 4886.188772757255, 5276.926302756789, 5450.939050407472, 5577.179631952125, 5602.573966566449, 4630.143423466669, 4701.623870090384, 4800.783964721526, 4854.490278520775, 5151.407588127413, 2539.022476346583, 2687.905923292675, 2699.879549986773, 2791.8185317954676, 2845.278606443072, 4785.0, 5483.424240454775, 5497.560195184456, 5762.366139724627, 5847.590668653153, 5082.797837362438, 5248.1163938685095, 5292.644773076021, 5399.676019438846, 5783.893435660644, 4431.889202769957, 5485.945140548623, 5489.968711576742, 5758.157389635277, 5802.883942321046, 4766.571008609242, 5370.221317908803, 5525.756704741401, 5533.944660553343, 5572.3034620672415, 4698.496481126007, 5135.666181698178, 5484.808031718871, 5502.038532256769, 5620.353659329229, 4913.901721965469, 5181.948180518298, 5730.481422422978, 5808.420011884531, 5909.349971503045, 3091.1916528830884, 3678.668919797231, 3694.3719567673024, 3737.841269206555, 3738.495303134042, 4886.507880980655, 5405.216313598421, 5489.835304940858, 5555.444555444556, 5590.6176763057765, 4650.0, 5007.47421520735, 5360.571154307724, 5620.100783874561, 5716.999050332351, 4880.243562247715, 5400.729963501888, 5544.918740845496, 5870.765169393177, 5890.469857712655, 5307.513896109095, 5492.752826122914, 5691.26013618227, 5748.626339287933, 5755.510781583444, 4666.786635474733, 5274.3670759509105, 5444.856580118061, 5828.970855145697, 5836.824895253149, 4848.684835485682, 5764.0, 5765.336986246468, 5783.768649253982, 5806.44516412777], "value": 4023.0748336320116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.6071635585936, 700.7057036044864, 708.2315687479085, 711.4273010226765, 743.4127039638686, 13761.518346857862, 14627.634309142277, 14705.044172128817, 14740.262986850641, 14760.188189649565, 13067.0, 13117.803232951514, 13171.0, 13183.472661093545, 13184.340782960862, 645.3901063494999, 664.5713514782963, 781.0978320040363, 788.373243271599, 798.5408390175643, 785.1834092543747, 798.9960050199741, 799.0730752327302, 800.927916487516, 801.1027649033091, 826.8304997475533, 854.1117238072397, 854.9615267312955, 855.1619412975257, 856.1866227084295, 834.8497270491309, 843.5191940593834, 846.1200351634293, 849.3375167369462, 852.3905407633509, 619.7211254935252, 622.8318354044428, 633.7971849008319, 635.2884769058637, 636.4971672378815, 13201.14192577489, 13294.40175192109, 13294.534691285759, 13321.600351989457, 13386.79919801194, 10795.5681772729, 13371.598852034358, 13382.799258011137, 13484.0, 13493.730125397535, 10991.890081099167, 11095.44522773866, 11265.662030139109, 11421.828672569918, 11615.883841161565, 3560.394732895414, 3597.3524765542193, 3728.0493474163914, 3764.7176461765475, 3772.4529943158086, 59367.70316148435, 77672.0, 89553.20893582157, 90902.54548727215, 95381.52309238478, 10126.291159618904, 10408.219383546264, 10473.895261047444, 10532.262741608167, 10771.784564308826, 16308.347666093461, 19935.900320498597, 20264.493387665425, 20309.984500775197, 20389.49026274355, 6365.822322870284, 7220.638968051681, 7323.12122545298, 7450.96274518624, 7646.9617651911385, 4128.91742165161, 4201.474815648044, 4283.421738065322, 4290.141971605692, 4317.330813723878, 3274.0832566881313, 3363.8654453822064, 3376.679215474526, 3379.915502112467, 3386.238096428284, 525.3197109742816, 625.2902955145851, 626.9216347956506, 638.0620487882804, 642.4795915308615, 632.9240491141093, 634.8984162533973, 635.6885126288086, 636.3096040795696, 654.214942069509, 7611.733589324347, 8416.74749757496, 8658.653653853775, 9228.95385523068, 9252.491112988715, 577.9364269930304, 631.3623240527008, 646.2261093298831, 661.8279247395711, 669.899515072743, 3563.6080031196548, 4070.9619047142787, 4460.3532487789735, 4534.841280555164, 4643.8374656886845, 92910.07089929013, 93086.53456732808, 93945.5302723482, 95563.0, 98773.50613246887, 47985.760071199424, 57597.712011439675, 75448.62275688586, 77997.0, 82520.58739706263, 75206.24793752102, 82766.58616706998, 83867.0, 85800.57099714462, 91060.0, 9195.954020229856, 9874.55564499585, 9884.505774711091, 9931.404115753077, 9968.352057116264, 51550.0, 53031.734841325546, 53763.73118134384, 53863.46136538585, 54361.0, 69155.65422172858, 74947.0, 75293.62353188418, 75477.86783198146, 75912.24087759273, 12920.935395322964, 12922.160059596095, 13013.089083764045, 13158.21050736959, 13204.933975330061, 12564.120511564102, 13630.863691363356, 14644.414223430944, 15252.542423727306, 15285.388584456941, 12630.179038362478, 12993.0, 13465.798013029616, 13793.034487586174, 13796.896248300312, 13280.493526458307, 13565.728685426433, 13626.0, 14035.157890526601, 14066.507672231422, 12842.0, 13409.32953352348, 13424.0, 13426.060175787601, 13711.520096796565, 10651.680449586525, 10657.20070994663, 10730.946345268223, 11027.669169924915, 11367.431628418712, 10570.0, 11057.336559806437, 11075.501602428072, 11131.888681113085, 11240.718982025188], "value": 7107.832549896396, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 133.0, 176.0, 121.0, 121.0, 159.0, 167.0, 121.0, 120.0, 120.0], "value": 134.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 150.0, 176.0, 133.0, 115.0, 117.0, 120.0, 141.0, 115.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 226.0, 223.0, 200.0, 197.0, 200.0, 198.0, 195.0, 198.0, 196.0], "value": 203.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 56.0, 83.0, 59.0, 61.0, 60.0, 59.0, 79.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 91.0, 74.0, 70.0, 73.0, 88.0, 88.0, 102.0, 123.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 86.0, 98.0, 87.0, 89.0, 86.0, 123.0, 132.0, 88.0, 87.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 100.0, 154.0, 121.0, 95.0, 94.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 88.0, 86.0, 90.0, 88.0, 91.0, 91.0, 90.0, 89.0], "value": 88.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 57.0, 56.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 82.0, 103.0, 103.0, 105.0, 75.0, 71.0, 71.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 82.0, 86.0, 84.0, 84.0, 86.0, 85.0, 88.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 147.0, 147.0, 150.0, 196.0, 168.0, 170.0, 198.0, 289.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 182.0, 212.0, 170.0, 167.0, 171.0, 169.0, 229.0, 201.0, 168.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 88.0, 92.0, 66.0, 61.0, 87.0, 89.0, 88.0, 89.0], "value": 79.7, "unit": "score"}]}]} 08:41:24 INFO - Return code: 0 08:41:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:24 ERROR - # TBPL SUCCESS # 08:41:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:24 INFO - 2016-11-17 08:41:24.937 screenresolution[1660:10563] starting screenresolution argv=screenresolution get 08:41:24 INFO - 2016-11-17 08:41:24.939 screenresolution[1660:10563] Display 0: 1600x1200x32@60 08:41:24 INFO - 2016-11-17 08:41:24.945 screenresolution[1661:10566] starting screenresolution argv=screenresolution list 08:41:24 INFO - Available Modes on Display 0 08:41:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:25 INFO - Intel Iris: 08:41:25 INFO - Chipset Model: Intel Iris 08:41:25 INFO - Type: GPU 08:41:25 INFO - Bus: Built-In 08:41:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:25 INFO - Vendor: Intel (0x8086) 08:41:25 INFO - Device ID: 0x0a2e 08:41:25 INFO - Revision ID: 0x0009 08:41:25 INFO - Displays: 08:41:25 INFO - Display: 08:41:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:25 INFO - Display Serial Number: 1600x1200 60 08:41:25 INFO - Main Display: Yes 08:41:25 INFO - Mirror: Off 08:41:25 INFO - Online: Yes 08:41:25 INFO - Rotation: Supported 08:41:25 INFO - Return code: 0 08:41:25 INFO - Running post-action listener: _resource_record_post_action 08:41:25 INFO - [mozharness: 2016-11-17 16:41:25.182869Z] Finished run-tests step (success) 08:41:25 INFO - Running post-run listener: _resource_record_post_run 08:41:25 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38728704; Write bytes: 655801344; Read time: 464; Write time: 2097 08:41:25 INFO - TinderboxPrint: CPU usage
54.2% 08:41:25 INFO - TinderboxPrint: I/O read bytes / time
38,728,704 / 464 08:41:25 INFO - TinderboxPrint: I/O write bytes / time
655,801,344 / 2,097 08:41:25 INFO - TinderboxPrint: CPU idle
2,215.1 (45.8%) 08:41:25 INFO - TinderboxPrint: CPU system
982.0 (20.3%) 08:41:25 INFO - TinderboxPrint: CPU user
1,644.6 (34.0%) 08:41:25 INFO - TinderboxPrint: Swap in / out
391,802,880 / 0 08:41:25 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 350607872; Write bytes: 346412544; Read time: 27209; Write time: 668 08:41:25 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36598784; Write bytes: 298149376; Read time: 440; Write time: 1392 08:41:25 INFO - Running post-run listener: _upload_blobber_files 08:41:25 INFO - Blob upload gear active. 08:41:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:25 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 08:41:25 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:41:25 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:41:26 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:41:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:27 INFO - (blobuploader) - INFO - Done attempting. 08:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:41:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:28 INFO - (blobuploader) - INFO - Done attempting. 08:41:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:30 INFO - (blobuploader) - INFO - Done attempting. 08:41:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:30 INFO - Return code: 0 08:41:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d117c4b189caf80663109d881f1dc7032b032217a2b9a990954a2ca551a539060b8ca00722b8aeed7edb65689d7bf7e8180faa1bede655b515c559adcd7504e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29938556f63da10b542a33909780004c0ff03d422de3fa23e7be121f81b45d21c4bbac71cd65d00adaeeebc7ba777d8b75b83a0044b1167e47cbd2f9d97c5315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d49baaae4811615b148e0e897b65c8e67a1fac5666876fc518d05945c75319dadb234a62b224db795140e773203704ddc1462714483a88d8e2f621fc9d1918"} 08:41:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:30 INFO - Contents: 08:41:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d117c4b189caf80663109d881f1dc7032b032217a2b9a990954a2ca551a539060b8ca00722b8aeed7edb65689d7bf7e8180faa1bede655b515c559adcd7504e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29938556f63da10b542a33909780004c0ff03d422de3fa23e7be121f81b45d21c4bbac71cd65d00adaeeebc7ba777d8b75b83a0044b1167e47cbd2f9d97c5315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d49baaae4811615b148e0e897b65c8e67a1fac5666876fc518d05945c75319dadb234a62b224db795140e773203704ddc1462714483a88d8e2f621fc9d1918"} 08:41:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:30 INFO - Copying logs to upload dir... 08:41:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.505144 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-17 08:41:30.743226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 08:41:30.746816) ========= 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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d117c4b189caf80663109d881f1dc7032b032217a2b9a990954a2ca551a539060b8ca00722b8aeed7edb65689d7bf7e8180faa1bede655b515c559adcd7504e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29938556f63da10b542a33909780004c0ff03d422de3fa23e7be121f81b45d21c4bbac71cd65d00adaeeebc7ba777d8b75b83a0044b1167e47cbd2f9d97c5315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d49baaae4811615b148e0e897b65c8e67a1fac5666876fc518d05945c75319dadb234a62b224db795140e773203704ddc1462714483a88d8e2f621fc9d1918"} build_url:https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010849 build_url: 'https://queue.taskcluster.net/v1/task/HmsHzj8wSTyuRXqrlyBcmw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d117c4b189caf80663109d881f1dc7032b032217a2b9a990954a2ca551a539060b8ca00722b8aeed7edb65689d7bf7e8180faa1bede655b515c559adcd7504e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29938556f63da10b542a33909780004c0ff03d422de3fa23e7be121f81b45d21c4bbac71cd65d00adaeeebc7ba777d8b75b83a0044b1167e47cbd2f9d97c5315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d49baaae4811615b148e0e897b65c8e67a1fac5666876fc518d05945c75319dadb234a62b224db795140e773203704ddc1462714483a88d8e2f621fc9d1918"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 08:41:30.783012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:41:30.783799) ========= 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.2cH8BLVcZM/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.xOkZ0u1pPQ/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005236 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:41:30.835684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 08:41:30.836039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 08:41:30.836519) ========= ========= Total master_lag: 0.18 =========