builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0265 starttime: 1484754623.19 results: success (0) buildid: 20170118062529 builduid: e81901d440264beb81c60c72a78d43db revision: 71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:23.189007) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:23.189440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-01-18 07:50:23.189723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-01-18 07:50:26.132664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:26.132995) ========= 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.rM41kX1Eer/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.VgfOeDRhKq/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 07:50:26-- 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% 18.3M=0.001s 2017-01-18 07:50:26 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098565 ========= master_lag: 0.87 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:27.098108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:27.098453) ========= 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.rM41kX1Eer/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.VgfOeDRhKq/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.024989 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:27.148947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 07:50:27.149287) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rM41kX1Eer/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.VgfOeDRhKq/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 07:50:27,248 truncating revision to first 12 chars 2017-01-18 07:50:27,249 Setting DEBUG logging. 2017-01-18 07:50:27,249 attempt 1/10 2017-01-18 07:50:27,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/71b2ddbe1f88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 07:50:28,955 unpacking tar archive at: mozilla-central-71b2ddbe1f88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.977910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 07:50:29.150481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:29.153825) ========= script_repo_revision: 71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:29.154323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:29.154651) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 07:50:29.174598) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-18 07:50:29.175026) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rM41kX1Eer/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.VgfOeDRhKq/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:50:29 INFO - MultiFileLogger online at 20170118 07:50:29 in /builds/slave/test 07:50:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:50:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:50:29 INFO - {'append_to_log': False, 07:50:29 INFO - 'base_work_dir': '/builds/slave/test', 07:50:29 INFO - 'blob_upload_branch': 'Firefox', 07:50:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:50:29 INFO - 'branch': 'Firefox', 07:50:29 INFO - 'buildbot_json_path': 'buildprops.json', 07:50:29 INFO - 'config_files': ('talos/mac_config.py',), 07:50:29 INFO - 'default_actions': ('clobber', 07:50:29 INFO - 'read-buildbot-config', 07:50:29 INFO - 'download-and-extract', 07:50:29 INFO - 'populate-webroot', 07:50:29 INFO - 'create-virtualenv', 07:50:29 INFO - 'install', 07:50:29 INFO - 'run-tests'), 07:50:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:50:29 INFO - 'download_minidump_stackwalk': True, 07:50:29 INFO - 'download_symbols': 'ondemand', 07:50:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:50:29 INFO - 'tooltool.py': '/tools/tooltool.py', 07:50:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:50:29 INFO - '/tools/misc-python/virtualenv.py')}, 07:50:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:50:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:50:29 INFO - 'installer_path': 'installer.exe', 07:50:29 INFO - 'log_level': 'info', 07:50:29 INFO - 'log_name': 'talos', 07:50:29 INFO - 'log_to_console': True, 07:50:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:50:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:50:29 INFO - 'opt_config_files': (), 07:50:29 INFO - 'pip_index': False, 07:50:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:50:29 INFO - 'cmd': ('bash', 07:50:29 INFO - '-c', 07:50:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:50:29 INFO - 'enabled': True, 07:50:29 INFO - 'halt_on_failure': False, 07:50:29 INFO - 'name': 'check_screen_resolution'},), 07:50:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:50:29 INFO - 'cmd': ('bash', 07:50:29 INFO - '-c', 07:50:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:50:29 INFO - 'enabled': True, 07:50:29 INFO - 'halt_on_failure': False, 07:50:29 INFO - 'name': 'check_screen_resolution'},), 07:50:29 INFO - 'run_cmd_checks_enabled': True, 07:50:29 INFO - 'sps_profile': False, 07:50:29 INFO - 'sps_profile_interval': 0, 07:50:29 INFO - 'suite': 'dromaeojs', 07:50:29 INFO - 'system_bits': '32', 07:50:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:50:29 INFO - 'title': 't-yosemite-r7-0265', 07:50:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:50:29 INFO - 'use_talos_json': True, 07:50:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:50:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:50:29 INFO - 'work_dir': 'build'} 07:50:29 INFO - [mozharness: 2017-01-18 15:50:29.384132Z] Running clobber step. 07:50:29 INFO - Running pre-action listener: _resource_record_pre_action 07:50:29 INFO - Running main action method: clobber 07:50:29 INFO - rmtree: /builds/slave/test/build 07:50:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:50:31 INFO - Running post-action listener: _resource_record_post_action 07:50:31 INFO - [mozharness: 2017-01-18 15:50:31.767194Z] Finished clobber step (success) 07:50:31 INFO - [mozharness: 2017-01-18 15:50:31.767317Z] Running read-buildbot-config step. 07:50:31 INFO - Running pre-action listener: _resource_record_pre_action 07:50:31 INFO - Running main action method: read_buildbot_config 07:50:31 INFO - Using buildbot properties: 07:50:31 INFO - { 07:50:31 INFO - "project": "", 07:50:31 INFO - "product": "firefox", 07:50:31 INFO - "script_repo_revision": "production", 07:50:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:50:31 INFO - "repository": "", 07:50:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:50:31 INFO - "buildid": "20170118062529", 07:50:31 INFO - "pgo_build": "False", 07:50:31 INFO - "basedir": "/builds/slave/test", 07:50:31 INFO - "buildnumber": 26, 07:50:31 INFO - "slavename": "t-yosemite-r7-0265", 07:50:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:50:31 INFO - "platform": "yosemite_r7", 07:50:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:50:31 INFO - "branch": "mozilla-central", 07:50:31 INFO - "repo_path": "mozilla-central", 07:50:31 INFO - "revision": "71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b", 07:50:31 INFO - "stage_platform": "macosx64", 07:50:31 INFO - "builduid": "e81901d440264beb81c60c72a78d43db", 07:50:31 INFO - "slavebuilddir": "test" 07:50:31 INFO - } 07:50:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:50:31 INFO - Running post-action listener: _resource_record_post_action 07:50:31 INFO - [mozharness: 2017-01-18 15:50:31.770924Z] Finished read-buildbot-config step (success) 07:50:31 INFO - [mozharness: 2017-01-18 15:50:31.771045Z] Running download-and-extract step. 07:50:31 INFO - Running pre-action listener: _resource_record_pre_action 07:50:31 INFO - Running main action method: download_and_extract 07:50:31 INFO - mkdir: /builds/slave/test/build/tests 07:50:31 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')]} 07:50:31 INFO - trying https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:50:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:50:33 INFO - Downloaded 1199 bytes. 07:50:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:50:33 INFO - Using the following test package requirements: 07:50:33 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:50:33 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:50:33 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:50:33 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'jsshell-mac.zip'], 07:50:33 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:50:33 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:50:33 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:50:33 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:50:33 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:50:33 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:50:33 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:50:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:50:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:50:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:50:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:50:34 INFO - Expected file size: 16328379 07:50:34 INFO - Obtained file size: 16328379 07:50:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:50:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:50:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:50:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:50:41 INFO - Expected file size: 16328379 07:50:41 INFO - Obtained file size: 16328379 07:50:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:50:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:50:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:50:49 INFO - Expected file size: 14403463 07:50:49 INFO - Obtained file size: 14403463 07:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:49 INFO - trying https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:50:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:50:51 INFO - Downloaded 69884297 bytes. 07:50:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:50:51 INFO - mkdir: /builds/slave/test/properties 07:50:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:51 INFO - Contents: 07:50:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:50:52 INFO - Running post-action listener: _resource_record_post_action 07:50:52 INFO - Running post-action listener: set_extra_try_arguments 07:50:52 INFO - [mozharness: 2017-01-18 15:50:52.448983Z] Finished download-and-extract step (success) 07:50:52 INFO - [mozharness: 2017-01-18 15:50:52.449125Z] Running populate-webroot step. 07:50:52 INFO - Running pre-action listener: _resource_record_pre_action 07:50:52 INFO - Running main action method: populate_webroot 07:50:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:52 INFO - '--tppagecycles', 07:50:52 INFO - '7'], 07:50:52 INFO - 'tests': ['tsvgm']}}, 07:50:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:50:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:50:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:50:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['damp', 'tps']}, 07:50:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'tests': ['damp', 'tps']}, 07:50:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['dromaeo_dom']}, 07:50:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:50:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['basic_compositor_video']}, 07:50:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:50:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['a11yr', 07:50:52 INFO - 'ts_paint', 07:50:52 INFO - 'tpaint', 07:50:52 INFO - 'sessionrestore', 07:50:52 INFO - 'sessionrestore_no_auto_restore', 07:50:52 INFO - 'tabpaint']}, 07:50:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:50:52 INFO - 'ts_paint', 07:50:52 INFO - 'tpaint', 07:50:52 INFO - 'sessionrestore', 07:50:52 INFO - 'sessionrestore_no_auto_restore', 07:50:52 INFO - 'tabpaint']}, 07:50:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:50:52 INFO - 'ts_paint', 07:50:52 INFO - 'tpaint', 07:50:52 INFO - 'sessionrestore', 07:50:52 INFO - 'sessionrestore_no_auto_restore', 07:50:52 INFO - 'tabpaint']}, 07:50:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:50:52 INFO - 'ts_paint', 07:50:52 INFO - 'tpaint', 07:50:52 INFO - 'sessionrestore', 07:50:52 INFO - 'sessionrestore_no_auto_restore', 07:50:52 INFO - 'tabpaint']}, 07:50:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['a11yr', 07:50:52 INFO - 'ts_paint', 07:50:52 INFO - 'tpaint', 07:50:52 INFO - 'sessionrestore', 07:50:52 INFO - 'sessionrestore_no_auto_restore', 07:50:52 INFO - 'tabpaint']}, 07:50:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['a11yr', 07:50:52 INFO - 'ts_paint', 07:50:52 INFO - 'tpaint', 07:50:52 INFO - 'sessionrestore', 07:50:52 INFO - 'sessionrestore_no_auto_restore', 07:50:52 INFO - 'tabpaint']}, 07:50:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['tsvgx', 07:50:52 INFO - 'tsvgr_opacity', 07:50:52 INFO - 'tart', 07:50:52 INFO - 'tscrollx', 07:50:52 INFO - 'cart', 07:50:52 INFO - 'tsvg_static']}, 07:50:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:50:52 INFO - 'tsvgr_opacity', 07:50:52 INFO - 'tart', 07:50:52 INFO - 'tscrollx', 07:50:52 INFO - 'cart', 07:50:52 INFO - 'tsvg_static']}, 07:50:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'talos_options': ['--disable-e10s'], 07:50:52 INFO - 'tests': ['tp5o']}, 07:50:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:50:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'talos_options': ['--disable-e10s', 07:50:52 INFO - '--xperf_path', 07:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:52 INFO - 'tests': ['tp5n']}, 07:50:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:50:52 INFO - 'talos_options': ['--xperf_path', 07:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:52 INFO - 'tests': ['tp5n']}}, 07:50:52 INFO - 'talos.zip': {'path': '', 07:50:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:52 INFO - Running post-action listener: _resource_record_post_action 07:50:52 INFO - [mozharness: 2017-01-18 15:50:52.467363Z] Finished populate-webroot step (success) 07:50:52 INFO - [mozharness: 2017-01-18 15:50:52.467500Z] Running create-virtualenv step. 07:50:52 INFO - Running pre-action listener: _resource_record_pre_action 07:50:52 INFO - Running main action method: create_virtualenv 07:50:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50:52 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 07:50:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:52 INFO - Using real prefix '/tools/python27' 07:50:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:50:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:56 INFO - Installing pip.................done. 07:50:56 INFO - Return code: 0 07:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:50:56 INFO - Reading from file tmpfile_stdout 07:50:56 INFO - Output received: 07:50:56 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) 07:50:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:56 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:50:56 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 07:50:56 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 07:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:56 INFO - 'HOME': '/Users/cltbld', 07:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:56 INFO - 'LOGNAME': 'cltbld', 07:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:56 INFO - 'MOZ_NO_REMOTE': '1', 07:50:56 INFO - 'NO_EM_RESTART': '1', 07:50:56 INFO - 'PAGER': '/bin/cat', 07:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:56 INFO - 'PWD': '/builds/slave/test', 07:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:56 INFO - 'SHELL': '/bin/bash', 07:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:50:56 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:56 INFO - 'USER': 'cltbld', 07:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:56 INFO - 'XPC_FLAGS': '0x0', 07:50:56 INFO - 'XPC_SERVICE_NAME': '0', 07:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:56 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 07:50:56 INFO - Cleaning up... 07:50:56 INFO - Return code: 0 07:50:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:56 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:50:56 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 07:50:56 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 07:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:56 INFO - 'HOME': '/Users/cltbld', 07:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:56 INFO - 'LOGNAME': 'cltbld', 07:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:56 INFO - 'MOZ_NO_REMOTE': '1', 07:50:56 INFO - 'NO_EM_RESTART': '1', 07:50:56 INFO - 'PAGER': '/bin/cat', 07:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:56 INFO - 'PWD': '/builds/slave/test', 07:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:56 INFO - 'SHELL': '/bin/bash', 07:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:50:56 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:56 INFO - 'USER': 'cltbld', 07:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:56 INFO - 'XPC_FLAGS': '0x0', 07:50:56 INFO - 'XPC_SERVICE_NAME': '0', 07:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:56 INFO - Downloading/unpacking psutil>=3.1.1 07:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:00 INFO - Installing collected packages: psutil 07:51:00 INFO - Running setup.py install for psutil 07:51:00 INFO - building 'psutil._psutil_osx' extension 07:51:00 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 07:51:01 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 07:51:01 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 07:51:01 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 07:51:01 INFO - building 'psutil._psutil_posix' extension 07:51:01 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 07:51:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:51:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:51:01 INFO - ^ 07:51:01 INFO - 1 warning generated. 07:51:01 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 07:51:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:01 INFO - Successfully installed psutil 07:51:01 INFO - Cleaning up... 07:51:01 INFO - Return code: 0 07:51:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:01 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:01 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 07:51:01 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 07:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:01 INFO - 'HOME': '/Users/cltbld', 07:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:01 INFO - 'LOGNAME': 'cltbld', 07:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:01 INFO - 'MOZ_NO_REMOTE': '1', 07:51:01 INFO - 'NO_EM_RESTART': '1', 07:51:01 INFO - 'PAGER': '/bin/cat', 07:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:01 INFO - 'PWD': '/builds/slave/test', 07:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:01 INFO - 'SHELL': '/bin/bash', 07:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:01 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:01 INFO - 'USER': 'cltbld', 07:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:01 INFO - 'XPC_FLAGS': '0x0', 07:51:01 INFO - 'XPC_SERVICE_NAME': '0', 07:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:51:02 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 07:51:02 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 07:51:02 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 07:51:02 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 07:51:02 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 07:51:02 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 07:51:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:51:04 INFO - Installing collected packages: mozsystemmonitor 07:51:04 INFO - Running setup.py install for mozsystemmonitor 07:51:04 INFO - Successfully installed mozsystemmonitor 07:51:04 INFO - Cleaning up... 07:51:04 INFO - Return code: 0 07:51:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:51:04 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')]} 07:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:04 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')]} 07:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:04 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:04 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 07:51:04 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 07:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:04 INFO - 'HOME': '/Users/cltbld', 07:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:04 INFO - 'LOGNAME': 'cltbld', 07:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:04 INFO - 'MOZ_NO_REMOTE': '1', 07:51:04 INFO - 'NO_EM_RESTART': '1', 07:51:04 INFO - 'PAGER': '/bin/cat', 07:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:04 INFO - 'PWD': '/builds/slave/test', 07:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:04 INFO - 'SHELL': '/bin/bash', 07:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:04 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:04 INFO - 'USER': 'cltbld', 07:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:04 INFO - 'XPC_FLAGS': '0x0', 07:51:04 INFO - 'XPC_SERVICE_NAME': '0', 07:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:05 INFO - Downloading/unpacking jsonschema==2.5.1 07:51:05 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 07:51:05 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 07:51:05 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 07:51:05 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 07:51:05 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 07:51:05 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 07:51:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:51:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:51:08 INFO - warning: no files found matching '*.txt' 07:51:08 INFO - no previously-included directories found matching 'build' 07:51:08 INFO - no previously-included directories found matching 'dist' 07:51:08 INFO - no previously-included directories found matching '.git*' 07:51:08 INFO - Installing collected packages: jsonschema, functools32 07:51:08 INFO - Running setup.py install for functools32 07:51:08 INFO - warning: no files found matching '*.txt' 07:51:08 INFO - no previously-included directories found matching 'build' 07:51:08 INFO - no previously-included directories found matching 'dist' 07:51:08 INFO - no previously-included directories found matching '.git*' 07:51:08 INFO - Successfully installed jsonschema functools32 07:51:08 INFO - Cleaning up... 07:51:08 INFO - Return code: 0 07:51:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:51:08 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')]} 07:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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')]} 07:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:08 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:08 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 07:51:08 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 07:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:08 INFO - 'HOME': '/Users/cltbld', 07:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:08 INFO - 'LOGNAME': 'cltbld', 07:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:08 INFO - 'MOZ_NO_REMOTE': '1', 07:51:08 INFO - 'NO_EM_RESTART': '1', 07:51:08 INFO - 'PAGER': '/bin/cat', 07:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:08 INFO - 'PWD': '/builds/slave/test', 07:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:08 INFO - 'SHELL': '/bin/bash', 07:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:08 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:08 INFO - 'USER': 'cltbld', 07:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:08 INFO - 'XPC_FLAGS': '0x0', 07:51:08 INFO - 'XPC_SERVICE_NAME': '0', 07:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:51:09 INFO - Cleaning up... 07:51:09 INFO - Return code: 0 07:51:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:09 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:09 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 07:51:09 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 07:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:09 INFO - 'HOME': '/Users/cltbld', 07:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:09 INFO - 'LOGNAME': 'cltbld', 07:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:09 INFO - 'MOZ_NO_REMOTE': '1', 07:51:09 INFO - 'NO_EM_RESTART': '1', 07:51:09 INFO - 'PAGER': '/bin/cat', 07:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:09 INFO - 'PWD': '/builds/slave/test', 07:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:09 INFO - 'SHELL': '/bin/bash', 07:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:09 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:09 INFO - 'USER': 'cltbld', 07:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:09 INFO - 'XPC_FLAGS': '0x0', 07:51:09 INFO - 'XPC_SERVICE_NAME': '0', 07:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51: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 07:51:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:51:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:51:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 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 07:51:12 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 07:51:13 INFO - Downloading docopt-0.6.1.tar.gz 07:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:51:13 INFO - Installing collected packages: blobuploader, requests, docopt 07:51:13 INFO - Running setup.py install for blobuploader 07:51:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:51:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:51:13 INFO - Running setup.py install for requests 07:51:13 INFO - Running setup.py install for docopt 07:51:14 INFO - Successfully installed blobuploader requests docopt 07:51:14 INFO - Cleaning up... 07:51:14 INFO - Return code: 0 07:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51: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')]} 07:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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')]} 07:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:14 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:14 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 07:51:14 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 07:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:14 INFO - 'HOME': '/Users/cltbld', 07:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:14 INFO - 'LOGNAME': 'cltbld', 07:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:14 INFO - 'MOZ_NO_REMOTE': '1', 07:51:14 INFO - 'NO_EM_RESTART': '1', 07:51:14 INFO - 'PAGER': '/bin/cat', 07:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:14 INFO - 'PWD': '/builds/slave/test', 07:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:14 INFO - 'SHELL': '/bin/bash', 07:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:14 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:14 INFO - 'USER': 'cltbld', 07:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:14 INFO - 'XPC_FLAGS': '0x0', 07:51:14 INFO - 'XPC_SERVICE_NAME': '0', 07:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-Kh4W_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-wSKoo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-OvuI_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-kQv2DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-BQ71x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-bN9Bic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-YP7wnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-mqm66K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-irO55p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-YLviUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-R4ramD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-JSrpYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-H9YsGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-cK9VwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-UYHlte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-NAm4Rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:16 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-7Idz1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:51:16 INFO - Running setup.py install for manifestparser 07:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:51:16 INFO - Running setup.py install for mozcrash 07:51:16 INFO - Running setup.py install for mozdebug 07:51:16 INFO - Running setup.py install for mozdevice 07:51:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:51:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:51:16 INFO - Running setup.py install for mozfile 07:51:16 INFO - Running setup.py install for mozhttpd 07:51:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Running setup.py install for mozinfo 07:51:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Running setup.py install for mozInstall 07:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Running setup.py install for mozleak 07:51:17 INFO - Running setup.py install for mozlog 07:51:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Running setup.py install for moznetwork 07:51:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:51:17 INFO - Running setup.py install for mozprocess 07:51:17 INFO - Running setup.py install for mozprofile 07:51:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:51:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:51:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:51:18 INFO - Running setup.py install for mozrunner 07:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:51:18 INFO - Running setup.py install for mozscreenshot 07:51:18 INFO - Running setup.py install for moztest 07:51:18 INFO - Running setup.py install for mozversion 07:51:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:51:18 INFO - Cleaning up... 07:51:18 INFO - Return code: 0 07:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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')]} 07:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:19 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:19 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 07:51:19 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 07:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:19 INFO - 'HOME': '/Users/cltbld', 07:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:19 INFO - 'LOGNAME': 'cltbld', 07:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:19 INFO - 'MOZ_NO_REMOTE': '1', 07:51:19 INFO - 'NO_EM_RESTART': '1', 07:51:19 INFO - 'PAGER': '/bin/cat', 07:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:19 INFO - 'PWD': '/builds/slave/test', 07:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:19 INFO - 'SHELL': '/bin/bash', 07:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:19 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:19 INFO - 'USER': 'cltbld', 07:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:19 INFO - 'XPC_FLAGS': '0x0', 07:51:19 INFO - 'XPC_SERVICE_NAME': '0', 07:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:19 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-OTu_T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:19 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)) 07:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:19 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-TLaoRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:19 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)) 07:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:19 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-AhpaFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-tK_Rlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-weD5hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-PojdDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-6_04V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-4KRT8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-xE7IZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-rk3hAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-yVaL6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:20 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:20 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-nLTKGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:21 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-RGg_gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:21 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)) 07:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:21 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-DHSVZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:21 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)) 07:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:21 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-eajHNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:21 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)) 07:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:21 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-foOfLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:21 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-hN_sfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:21 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)) 07:51:21 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)) 07:51:21 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)) 07:51:21 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)) 07:51:21 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:51:21 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:51:21 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 07:51:21 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 07:51:21 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 07:51:21 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 07:51:21 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 07:51:21 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 07:51:24 INFO - Downloading blessings-1.6.tar.gz 07:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:51:24 INFO - Installing collected packages: blessings 07:51:24 INFO - Running setup.py install for blessings 07:51:24 INFO - Successfully installed blessings 07:51:24 INFO - Cleaning up... 07:51:24 INFO - Return code: 0 07:51:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:25 INFO - Reading from file tmpfile_stdout 07:51:25 INFO - Current package versions: 07:51:25 INFO - blessings == 1.6 07:51:25 INFO - blobuploader == 1.2.4 07:51:25 INFO - docopt == 0.6.1 07:51:25 INFO - functools32 == 3.2.3-2 07:51:25 INFO - jsonschema == 2.5.1 07:51:25 INFO - manifestparser == 1.1 07:51:25 INFO - mozInstall == 1.12 07:51:25 INFO - mozcrash == 1.0 07:51:25 INFO - mozdebug == 0.1 07:51:25 INFO - mozdevice == 0.49 07:51:25 INFO - mozfile == 1.2 07:51:25 INFO - mozhttpd == 0.7 07:51:25 INFO - mozinfo == 0.9 07:51:25 INFO - mozleak == 0.1 07:51:25 INFO - mozlog == 3.4 07:51:25 INFO - moznetwork == 0.27 07:51:25 INFO - mozprocess == 0.24 07:51:25 INFO - mozprofile == 0.28 07:51:25 INFO - mozrunner == 6.13 07:51:25 INFO - mozscreenshot == 0.1 07:51:25 INFO - mozsystemmonitor == 0.3 07:51:25 INFO - moztest == 0.8 07:51:25 INFO - mozversion == 1.4 07:51:25 INFO - psutil == 3.1.1 07:51:25 INFO - requests == 1.2.3 07:51:25 INFO - wsgiref == 0.1.2 07:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:25 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 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:25 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 07:51:25 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 07:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:25 INFO - 'HOME': '/Users/cltbld', 07:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:25 INFO - 'LOGNAME': 'cltbld', 07:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:25 INFO - 'MOZ_NO_REMOTE': '1', 07:51:25 INFO - 'NO_EM_RESTART': '1', 07:51:25 INFO - 'PAGER': '/bin/cat', 07:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:25 INFO - 'PWD': '/builds/slave/test', 07:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:25 INFO - 'SHELL': '/bin/bash', 07:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:25 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:25 INFO - 'USER': 'cltbld', 07:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:25 INFO - 'XPC_FLAGS': '0x0', 07:51:25 INFO - 'XPC_SERVICE_NAME': '0', 07:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 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)) 07:51:25 INFO - Cleaning up... 07:51:25 INFO - Return code: 0 07:51:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f112b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f115768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6b8d68170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, '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.rM41kX1Eer/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.VgfOeDRhKq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 07:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:51:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:25 INFO - 'HOME': '/Users/cltbld', 07:51:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:25 INFO - 'LOGNAME': 'cltbld', 07:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:25 INFO - 'MOZ_NO_REMOTE': '1', 07:51:25 INFO - 'NO_EM_RESTART': '1', 07:51:25 INFO - 'PAGER': '/bin/cat', 07:51:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:25 INFO - 'PWD': '/builds/slave/test', 07:51:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:25 INFO - 'SHELL': '/bin/bash', 07:51:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:25 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:25 INFO - 'USER': 'cltbld', 07:51:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:25 INFO - 'XPC_FLAGS': '0x0', 07:51:25 INFO - 'XPC_SERVICE_NAME': '0', 07:51:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:51:25 INFO - Cleaning up... 07:51:25 INFO - Return code: 0 07:51:25 INFO - Running post-action listener: _resource_record_post_action 07:51:25 INFO - Running post-action listener: _start_resource_monitoring 07:51:25 INFO - Starting resource monitoring. 07:51:25 INFO - [mozharness: 2017-01-18 15:51:25.784421Z] Finished create-virtualenv step (success) 07:51:25 INFO - [mozharness: 2017-01-18 15:51:25.785423Z] Running install step. 07:51:25 INFO - Running pre-action listener: _resource_record_pre_action 07:51:25 INFO - Running main action method: install 07:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:51:26 INFO - Reading from file tmpfile_stdout 07:51:26 INFO - Detecting whether we're running mozinstall >=1.0... 07:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:51:26 INFO - Reading from file tmpfile_stdout 07:51:26 INFO - Output received: 07:51:26 INFO - Usage: mozinstall [options] installer 07:51:26 INFO - Options: 07:51:26 INFO - -h, --help show this help message and exit 07:51:26 INFO - -d DEST, --destination=DEST 07:51:26 INFO - Directory to install application into. [default: 07:51:26 INFO - "/builds/slave/test"] 07:51:26 INFO - --app=APP Application being installed. [default: firefox] 07:51:26 INFO - mkdir: /builds/slave/test/build/application 07:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:51:48 INFO - Reading from file tmpfile_stdout 07:51:48 INFO - Output received: 07:51:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:51:48 INFO - Running post-action listener: _resource_record_post_action 07:51:48 INFO - [mozharness: 2017-01-18 15:51:48.115402Z] Finished install step (success) 07:51:48 INFO - [mozharness: 2017-01-18 15:51:48.115571Z] Running run-tests step. 07:51:48 INFO - Running pre-action listener: _resource_record_pre_action 07:51:48 INFO - Running main action method: run_tests 07:51:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:48 INFO - 2017-01-18 07:51:48.130 screenresolution[1625:7338] starting screenresolution argv=screenresolution get 07:51:48 INFO - 2017-01-18 07:51:48.133 screenresolution[1625:7338] Display 0: 1600x1200x32@60 07:51:48 INFO - 2017-01-18 07:51:48.139 screenresolution[1626:7340] starting screenresolution argv=screenresolution list 07:51:48 INFO - Available Modes on Display 0 07:51:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:48 INFO - Intel Iris: 07:51:48 INFO - Chipset Model: Intel Iris 07:51:48 INFO - Type: GPU 07:51:48 INFO - Bus: Built-In 07:51:48 INFO - VRAM (Dynamic, Max): 1536 MB 07:51:48 INFO - Vendor: Intel (0x8086) 07:51:48 INFO - Device ID: 0x0a2e 07:51:48 INFO - Revision ID: 0x0009 07:51:48 INFO - Displays: 07:51:48 INFO - Display: 07:51:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:48 INFO - Display Serial Number: 1600x1200 60 07:51:48 INFO - Main Display: Yes 07:51:48 INFO - Mirror: Off 07:51:48 INFO - Online: Yes 07:51:48 INFO - Rotation: Supported 07:51:48 INFO - Return code: 0 07:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:51:48 INFO - Python 2.7.3 07:51:48 INFO - Return code: 0 07:51:48 INFO - grabbing minidump binary from tooltool 07:51:48 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')]} 07:51:48 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 0x10eef0d30>, '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 0x10ee17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eee5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:51:48 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 07:51:48 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 07:51:48 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 07:51:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:51:48 INFO - Return code: 0 07:51:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:51:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:51:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:51:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:51:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0265 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rM41kX1Eer/Render', 07:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:48 INFO - 'HOME': '/Users/cltbld', 07:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:48 INFO - 'LOGNAME': 'cltbld', 07:51:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:51:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:48 INFO - 'MOZ_NO_REMOTE': '1', 07:51:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:51:48 INFO - 'NO_EM_RESTART': '1', 07:51:48 INFO - 'PAGER': '/bin/cat', 07:51:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:48 INFO - 'PWD': '/builds/slave/test', 07:51:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:48 INFO - 'SHELL': '/bin/bash', 07:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VgfOeDRhKq/Listeners', 07:51:48 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 07:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:48 INFO - 'USER': 'cltbld', 07:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:48 INFO - 'XPC_FLAGS': '0x0', 07:51:48 INFO - 'XPC_SERVICE_NAME': '0', 07:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:51:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:51:48 INFO - mozversion application_buildid: 20170118062529 07:51:48 INFO - mozversion application_changeset: 71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b 07:51:48 INFO - mozversion application_display_name: Nightly 07:51:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:51:48 INFO - mozversion application_name: Firefox 07:51:48 INFO - mozversion application_remotingname: firefox 07:51:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:51:48 INFO - mozversion application_vendor: Mozilla 07:51:48 INFO - mozversion application_version: 53.0a1 07:51:48 INFO - mozversion platform_buildid: 20170118062529 07:51:48 INFO - mozversion platform_changeset: 71b2ddbe1f88123ee0b20eb17a133ce5fa8fac9b 07:51:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:51:48 INFO - mozversion platform_version: 53.0a1 07:51:48 INFO - using testdate: 1484754708 07:51:48 INFO - actual date: 1484754708 07:51:48 INFO - starting webserver on 'localhost:49238' 07:51:48 INFO - SUITE-START | Running 2 tests 07:51:48 INFO - TEST-START | dromaeo_css 07:51:48 INFO - operating with platform_type : mac_ 07:51:48 INFO - Initialising browser for dromaeo_css test... 07:51:48 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpBxFend/profile http://localhost:49238/getInfo.html) 07:51:50 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 07:51:50 INFO - PROCESS | 1636 | colorDepth:24 07:51:50 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 07:51:50 INFO - PROCESS | 1636 | __metrics 07:51:51 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:51:51 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:51 INFO - TEST-INFO | 1636: exit 0 07:51:51 INFO - Browser initialized. 07:51:51 INFO - Running cycle 1/1 for dromaeo_css test... 07:51:51 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpBxFend/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:03 INFO - PROCESS | 1638 | RSS: Main: 235143168 07:52:03 INFO - PROCESS | 1638 | 07:55:08 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 07:55:10 INFO - PROCESS | 1638 | RSS: Main: 385822720 07:55:10 INFO - PROCESS | 1638 | 07:56:54 INFO - PROCESS | 1638 | ************************* 07:56:54 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 07:56:54 INFO - PROCESS | 1638 | 07:56:54 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:56:54 INFO - PROCESS | 1638 | Full stack: 07:56:54 INFO - PROCESS | 1638 | ************************* 07:58:12 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 07:58:13 INFO - PROCESS | 1638 | RSS: Main: 367341568 07:58:13 INFO - PROCESS | 1638 | 08:01:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 08:01:16 INFO - PROCESS | 1638 | RSS: Main: 356671488 08:01:16 INFO - PROCESS | 1638 | 08:04:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 08:04:19 INFO - PROCESS | 1638 | RSS: Main: 336625664 08:04:19 INFO - PROCESS | 1638 | 08:07:22 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 08:07:23 INFO - PROCESS | 1638 | RSS: Main: 326656000 08:07:23 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 08:10:26 INFO - PROCESS | 1638 | RSS: Main: 496353280 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | __start_tp_report 08:10:26 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 08:10:26 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 08:10:26 INFO - PROCESS | 1638 | |i|pagename|runs| 08:10:26 INFO - PROCESS | 1638 | |0;dojo.html;2951.7933744637858;3378.5101160331747;3380.0873764083713;3389.694927456529;3418.641042690517;5589.636673616217;5639.577031722617;5667.631603945741;5765.336986246578;5766.394528574497;5654.151877218419;5697.974364614368;5707.086866101425;5712.600117991732;5712.71436428179;5193.376794784622;5210.5310522053005;5235.162374020158;5249.055170069386;5292.947070529303;5279.445658205871;5285.233641122035;5293.6294459387855;5296.2055691646365;5301;5287.709175995319;5291.576673866081;5295.0733621616255;5295.496927791873;5298.311219541454;5279.63042587019;5280.075986702331;5282.313299271109;5284.947150528523;5289.894202115975;4296.484421869396;5155.536001759822;5241.0828105081455;5243.134882744343;5246.160614301693;5745.166950792153;5772.538196944234;5819.388964158745;5894.3810899855325;5905.143754155623;6312.337204593543;6315.74737010519;6328;6338.556301058928;6350.460210882081;5228.686278823245;6223.315435302113;6224.190855188796;6250.281217659936;6290.811275661737;4893.73084480357;5859.619124756962;5870.354261031283;5874.441928016831;5901.734421951022;6267.62394256346;6291.433770960635;6304.653244071528;6307.5269354798575;6320.968395157995;6068.9696551517845;6101.338204344246;6123.4488895999575;6138.7237574309265;6144.4469997699525;6269.279032911182;6290.308066112724;6299.685015749286;6300.653464059521;6304.747810087637;6161.137440758297;6195.566310358322;6260.467860231931;6261.5616906816085;6264.342244064399;6107.735039974563;6146.340488068286;6296.181496405529;6308.369163083655;6312.558120931582;4413.492448368414;4982.900341993212;5022.2466630005065;5025.547700706954;5056.469070747518;4466.932996005063;4469.664775141812;4473.821047158077;4495.100979804052;4496.617787488035;5616.354119276336;5834.545553839991;5839.941600583939;5855.765769369263;5858.033424484997;5138.3577052868395;6214.161088253028;6224.1597384352535;6270.592411493239;6279.623222606659;5853.595266838976;5895.469407753323;5904.143899134601;5911.231539899785;5928.436798504135;5418.051840927822;5446.455354464601;5453.672779633234;5492.176173573996;5506.394296627368;6329.999999999908;6339.429451349401;6353.110564521063;6365.045243213555;6396.104545363746;6290.182276304051;6302.212223472066;6317.305096439296;6320.273168585672;6320.841978950379;6208.3791620839365;6271.843203919756;6326.588771729823;6343.0485427186295;6438.163038805113;6268.717907694256;6280.811575652738;6285.402886725754;6285.905711414424;6303.842403939938;6170.043643235305;6304.369563043659;6316.147320111726;6322.178116844781;6325.557210995186;5542.63972841764;5749.453801888814;5827.096799996008;6175.9073613894925;6221.9377806221355;5993.280806303272;6018.4583387493585;6059;6071.058985857199;6122.642120310999;5969.134475501115;5991.460768530853;5998.1002849572915;5999.820005399845;6013.9699301503215;5207.3230480037355;6050.90923636137;6107.633541987495;6127.816165515042;6131.601445906002;5832.9708351457975;5877.089051197071;5881.235439392852;5942.989691752326;6008.24896887889 08:10:26 INFO - PROCESS | 1638 | |1;ext.html;481.99036019279635;501.18557344315485;502.9889921258271;504.63666160364545;522.8536009917225;28876.422471550555;41523.58476415235;43044;43078.56921430793;45415;44411.333829992494;44711.77644111783;44821.551784482144;44823.77588112063;44832.65502034944;8442.957785211096;9278.211352035085;9495.81008379832;9510.09654082861;9524.904635966848;8466.280366168883;11130.833037504444;11384.260023098472;11416.71458213543;11610.767784644302;11416.657500275005;11475.598354057609;11481.483333250024;11504.482298296554;11513.136514761385;8438.704645337384;8676.436031657986;11387.373694446802;11476;11481.425928703573;11079.778404431947;11400.315981041163;11437;11565.768684626344;11613.709657258552;42398;42673.81229721704;42782.57217427817;42799.35800962988;42840.57159428428;3739.326921154191;3858.421236814472;4101.056756945889;4107.774072426016;4114.19773144237;31209.531857022164;31306;31645.683543164505;31964.680353196403;32640.83679581587;3205.743540516753;3205.759568032407;3214.5338925855854;3250.5124231365485;3327.517509961042;472211;474347;474535;474613;474885;66238;66632.33367666358;66690.66654666695;66743.66628166828;66887;66367.66816165888;68844.3115568838;68975.31024689689;69133.96299055518;69209.65395173093;15965.962212456154;16563.66872662564;16568.585785355463;16596;16693.081880496447;11392.94303528477;11693.941530292293;12611.684707882376;12701.745965080647;12732.936335318263;16587.170641467877;18423.631527369376;18776.342828000954;18885;19612.901935490518;6632.436242919406;6701;6765.613049324877;6770.255271920085;6781.423578995742;763.6678045050421;839.4501601451059;857.9056303806576;878.2447095497866;882.4352414454754;29217.707822921922;30442.695573044428;30512.389752204832;30636.846815765777;31276.374472510877;1057.6668349469892;1069.6202847989007;1098.4343063322394;1108.3017698849835;1217.2088142707312;15463.5360939172;15665.060096394252;15727.764083538756;16089;16157.515274541782;559846;564130;564687;564745;565559;63051.36948630547;63086.0537091944;63089;63119.36880631227;63296.36703632997;1277.9872201277867;1356.647271709343;1367.1387026173645;1425.7148570285983;1436.0665567381286;28559;29075.127746167647;29292.853535732185;29697;29837.5524367139;47978.80052998563;48681.756591216814;48700;48740.512594875014;48785;494331;494783;496218;496411;498943;22617.886910565343;23135.76864231336;24993.625095623946;25339.746602533738;25359.47843129418;36990.07524811794;44544.554554454044;44572.10855782931;45465.77267113643;47068.058638827715;31905.36189276155;34766.65233347634;36175;36192;37260.06849828776;35806.82096589501;35995;36428.81785591161;36696.449553257255;36927;35324.293514130084;35736.642633573334;36412.4538131923;36563.63436365602;36564.0858978517;30085.849570752005;31301.06096817099;31628.678988705855;31715.524267135548;32018;23430.531389371776;23791.881040594686;24104.39739006469;24127;24179.75820241775 08:10:26 INFO - PROCESS | 1638 | |2;jquery.html;342.6830182081575;352.393882522062;388.970827187961;395.6874069485108;422.78437996621716;15323.38706451742;15842.207889605532;19708.507287317825;20963.951802409894;21897.671534926987;20627.69058464124;20681.482962925897;21173.57652846942;21232.40756943228;21423.785762142375;5523.7238138093035;5833.387494313079;5833.562482813806;5837.299524057119;5844.532437405019;5540.529055030327;5731.025725626653;5733.283339582552;5773.48038676519;5786.884262314751;5719.370869204384;5727.11229759388;5730.341010783772;5741.569382296324;5743.425657434244;5234.607404444682;5237.45006774289;5563.693996830173;5675.262215911946;5729.82810515681;4654.371659825948;4803.703000189929;4967.031428871372;5030.949690503085;5058.215976523645;25226.621600676004;25281.98872045116;25288.873555632104;25463.36341591475;25728.614070788954;2723.7412445817617;2750.6699196096397;2751.9724802752116;2752.931176720578;2754.6832114306712;14823.407063717439;15490.457833975757;15506.5348039559;15692;16044.75932861008;1780.2344991653583;1798.3346161920174;1800.4958611588777;1817.400257914898;1855.7123645834781;129514;129623;130182;130916.34541827325;131058.79176645185;10101.898981010096;11292.322460652387;11310.434478276053;11508.482118304697;11640.359780212;13162.210267383987;13418.93290533541;13560.728785424237;14132.222727750073;14156.575302740934;8474.27968622674;8549.914500854911;8614.22471977525;8622.741317760352;8710.564471776512;8473.449225800303;8500.064992850781;8505.659773608986;8645.481271123752;8709.259712924346;6240.81424529338;6641.800745977628;7018.1929078155645;7039.1553013638695;7040.3663670269925;1862.6181632765251;1907.6947688369794;1909.7326374307331;1911;1911.235505797692;337.31861639488096;1054.8206804843196;1054.915606751458;1055.4775386183735;1106.1095817866694;11132.05377542918;11502.94248528752;11550.306981581132;11902.285862848257;12048.770977369215;426.9594388533084;442.69675272438485;451.39513052509136;453.68922288232005;455.4944012146515;5676.2393551934865;6029.6683682397015;6051.939480605226;6134.539909506716;6154.569180157346;527175;536116;571894.1242350342;584967;589729.5648739275;145856;153567;160691;162151.37848621598;166849;1024.9846252306222;1035.425338936882;1075.2097208551866;1081.6106201767357;1086.4459125845876;18904.621907562047;19258.61482770365;19544.706829397284;19559.60880782405;19581.412557622723;58571;59442.70278648579;59498;60650.09024864719;61397;88855;91331;91984;92014;92404;8107.918920810952;8351.498910065415;8529.616167272612;8622.913770862462;8738.21356077956;9591.808163836544;12829.422675979416;13388.330583470983;13573.457061717421;13594.932025340206;11237.988581027746;11349.432528373713;11724.765504690029;11787.587434439753;11874.940625297164;11281.153913456359;11443;11486.253393529394;11628.302301861915;11833.053355731692;9456.338056336266;11672.591459298883;11836.171467997157;11891.940540297242;11905.523779049088;8051.396145289244;8324.417290789586;8428.873566896624;8500.277476414327;8765.298776098025;10100.84848727255;11287.25553961261;11684.649460516199;11707.531698731955;11822.11334149925 08:10:26 INFO - PROCESS | 1638 | |3;mootools.html;1259.5465632372347;1458.343745314608;1472.4772705689486;1480.1341215389;1491.7389456845062;8027.237412445816;8422.452540584858;8453.57732113395;8466.111058338878;8472.449290796094;7337.449691273163;7606.619669016554;7612.543247405146;8076.434649574518;8174.95912520438;2290.874001929893;2329.324495896188;2333.556624241389;2335.1710142899283;2339.3800642829665;2285.954280914381;2319.6636487709357;2321.442853715113;2321.4776675248104;2331.9300420987397;2025.8885761283123;2098.1187901081585;2236.1837929155904;2292.3123063081093;2313.467902382453;2312.1791763923816;2314.9421264468356;2319.1998760427628;2322.628379459278;2326.8254880883915;2251.8311126665403;2304.976950230493;2322.93031209064;2326.302109367183;2328.732195797488;8279.751607451786;8364.247217750371;8364.916350836475;8371.706990255372;8378.874316885252;5006.4492905780335;5123.2315152727015;5167.656409333563;5178.197379406198;5184.922226166611;3320.9833950830093;3380.8816691415927;3416.3167366526545;3500.177458297298;3523.1720545671747;1061.8354155105972;1139.0944199361527;1188.8335633011386;1219.1892391559602;1227.9201851879689;9690.273229507815;9954.755655543056;10665.253432259746;10852.023317901427;10860.348379097279;4531.864044078683;4588.632909367243;4659.697119687209;4661.487236403993;4699.577038066522;9508.429494230368;9511.857322140173;9514.238860891111;9521.190698790542;9533.52332383378;5266.789328426897;5274.26160337553;5277.2875661785165;5293.3647962244;5300.628955973122;4246.554111818276;4304.461942257218;4735.763211839394;4738.905221895543;4810.230363141881;3747.2880152770886;3801.201747633028;3851.4030325299623;3872.8257228424786;3878.3600705883778;1248.2884755689352;1270.314030423561;1272.204871955028;1281.814136950137;1282.9166104203198;776.9883451748228;837.7989282572139;903.1916434790957;903.7153296711515;935.4948327902856;5294.444083371268;5406.053940560386;5506.712605441324;5622.690752008597;5640.661560306395;989.6091044037709;990.3513198854762;1024.1857723110145;1026.1124127629546;1050.632278702448;3554.8222588870453;3657.8902632921054;3711.183539621279;3782.527184101987;3804.4673745675627;9699.127078562964;9859.556319965619;9983.800323993479;9990.200783937413;9995.70012899614;9397.859032114524;9722.173615242642;9918.900810991941;9930.453825039693;9970.800583988279;7491.250874912465;7744.728934487266;7744.7676569703;7751.883721744179;7805.960970195113;5313.760880760297;5408.296921400193;5471.316085489314;5484.643498172606;5550.5282051026115;8518.23335899772;8789.560521974003;9263.16631503168;9381.390209636353;9399.624015039595;9092.090790920854;9180.862287065833;9330.253579713743;9364.438133712;9405.905940940504;6349.015902534929;6919;7145.321194486515;7683.884741728991;7811.921880781347;7533.886991695019;7798.532088074734;7837.373010159287;7926.960365198137;7940.523568585903;7020.508564400443;7121.501494895515;7142.785716428515;7196.496245262991;7266.7093316266755;6892.758753443605;6947.548409353376;6963.4777391694815;7050.541714788523;7058.364747172779;6192.535559833121;6279.089532017741;6310.652914089769;6364.77723279683;6372.904406433814;4298.376735373416;4822.348982887405;4842.128416884994;4879.56083952446;4953.281774142802;4046.4132700758814;4811.542903424169;4923.236898280772;4949.653524253267;5076.873078172927 08:10:26 INFO - PROCESS | 1638 | |4;prototype.html;292.9604503392042;315.8231390421364;349.882789265596;367.23431645020133;367.9172186258092;4988.551030407262;5204.817831375903;5227.215917612355;5266.603041038527;5298.867528311789;4286.678499112563;5056.292119103319;5067.668872318738;5129.9227162295965;5203.843884683456;3396.677315655021;4099.24164029654;4100.343944968806;4105.876823695294;4127.422160897469;3451.982740086296;3563;4050.1494686115952;4143.689223308249;4145.730527515701;4057;4086.8569600064;4097.180563887219;4099.44657471242;4115.567865374138;3636.6726994570618;4061.8626784500534;4061.8829821799095;4082.2856000199845;4093.3450647896193;3015.3969206158636;3422.863085476578;3629.510016147839;3635.2184280379847;3635.763675361093;4235.87292381226;4507.842225522091;4920.532549407801;5056.418511871145;5153.793848246066;4327.350897365389;4685.976570117127;4687.273472611751;4689.95310046902;4720.244760838249;5011.899762004739;5460.453954604547;5476.288082549243;5492.533134683556;5499.642523235977;3341.599008119041;3345.631980482145;3854.7494412863075;4008.67930565557;4014.638682518558;5427.294451721251;5657.405972372882;5736.024875771129;5740.282464691913;5761.88476230473;3377.071305391037;3562.7886518583805;3745.9438108428394;4074.5925407459017;4078.3678529827926;3625.655562721537;4132.380142978577;4135.937960930589;4157.812898419578;4160.771157586301;3949.565547789741;4463.66522510813;4472.39622650938;4496.887577810581;4524.185646583646;5425.972870135624;5475.4524547544925;5493.533049690741;5522.502974732293;5536.61584603849;1017.1659239423601;1139.7777433400572;1181.5687274144875;1190;1206.9155159138952;702.7891632510226;751.5791156952124;811.6185392865344;855.9529225892636;858.6694122762781;4504.459464864237;4831.251156070814;4836.395450568679;4839.975800120977;4910.852674419773;4679.64902632304;4807.326974223612;5013.298138260647;5401.621886467988;5410.185818997597;4180.540140584533;4672.766361681903;4785.186518291899;4800.559832050371;4860.927086093711;2279.202279202299;2468.568000599888;2515.9119430819833;2822.20978126125;2828.1939647200447;5338.279332290169;5349.53929059608;5567.409021181315;5574.721263936868;5608.9439105609235;4867.977724677787;5428.4842939920645;5465.4261302563455;5475.534579560703;5517.751701173376;5286.286351342596;5504.559635229252;5512.724363781795;5548.55611551083;5560.860978475571;4145.357469592218;4612.769361531977;5078.410010894397;5319.973400132974;5325.124432806241;5235.712035838065;5286.70028537572;5297.867553311198;5308.46915308466;5308.734563271898;4734.124187025412;5457.972710136424;5522.889542209214;5534.972325138348;5598.832035038955;2997.6252968378953;3359.8656053757577;3521.2605352875157;3614.2771445711487;3691.8892433227047;4976.765102683285;5584.274044374205;5626.971865140648;5632.662040277596;5633.436656334334;4687.742174180453;5238.449962753856;5340.919886201787;5469.507744302873;5518.392976772471;4425.734455932655;4812.5215514009615;5176.3011993381915;5304.965531721277;5404.459554044564;4642.558956899089;4759.833405830779;5067.87330316745;5235.58639167415;5272.815451459181;4629.8471210885755;5025.562602137887;5270.73646317675;5499.890002199853;5529.502344788988;5372.301600791872;5374.280230326258;5378.858279124974;5383.650062745909;5398.64908780928 08:10:26 INFO - PROCESS | 1638 | |5;yui.html;725.6698202317949;734.2840730287967;777.3392616276166;802.2227634436928;812.9154419236354;14468.421263149474;15387.461438849643;15416.845831541681;15435.305411256493;15438.459653912116;14088.71822563548;14226.075305105162;14235;14257.857421425782;14270.857291427083;691.0463560286822;714.4641518860855;742.4876834983844;851.5444237333028;880.8194320164367;868.1405408645459;874.0778478704964;874.1695389380114;882.7528292078229;887.1261807119981;933.3932943586655;935.6865450074233;937.1659223291276;939.4034787909692;942.5664194470552;714.935655790976;929.586334081334;930.9627614895396;931.1805611062256;932.5290728182292;551.1127085392515;673.4746897419972;696.1298377028714;696.2793508718503;704.9964750176267;14697.412103515846;14758.631034224123;14763.630909227248;14768.187749673763;14833.554993350217;13336.466541338335;13470.191788492624;13508.91928645706;13589.184648920998;13593.59219223425;11961.581344652895;12103.273803571814;12267.754644907141;12268.957138643225;12466.626001219978;3562.5190599269285;3662.7729710547;3752.4371344298575;3856.3636999895266;3883.475730776337;91305;93114.06885931121;93824.53087734585;96862.03137968671;96985.0301496983;10720.678379648467;10770.892291077145;10827.83758243627;10893.782124357469;10898.18263630215;20313.492162695755;20896.268630597857;20928.686069708965;20945.685814712793;20962.371128866158;7514.6618402172035;7571.924280757122;7731.381489480828;7734.381249500027;7765.572893490912;4251.17102165081;4360.193364227564;4364.367166760802;4367.323064924942;4496.775161241991;3509.754317197772;3518.2963407318125;3596.892093237207;3665.193657395369;3672.0636237759736;625.3621306267581;639.5491178718992;672.3444641474621;680;686.5983399711125;590.3034419385167;624.6689254695019;641.7176442365344;676.6008055247428;700.9018737376771;9708.660196893215;9884.357516761387;10274.897251027394;10477.580896764197;10657.25399222047;573.3005733005726;576.9942300577025;609.3906093906094;645.4642646603309;705.7741522712786;4617.8152873884665;4670.813167473331;5051.621128415383;5057.367829021372;5060.974695126574;86555;104237;106300.46849765857;106583.93416065896;107732;88132;88665;88680.55659721661;89263.66104508437;92383;68723.65638171877;76692.99999999888;78208.60895695485;78408.60795695985;80341.59829200816;9764.462954537285;9771.560279787569;9777.511124443892;9779.41323520591;9807.656732014346;44998;46854;48023;48121.518784811706;49361.50638493569;57460;61772.69113654403;65775;69186.65406672934;69464.6526767363;12170.45232964501;12335.75328493443;12668.936655316664;12806.231626102464;13653.249071301174;14816.777748334;15014.249287535798;15056.698866022838;15158.393664253748;15357.923210383877;13860.41728033889;13885.166889986633;14158.50445234412;14229.430822766974;14534.418623255375;13595.728085438433;13937.30313484342;14147.504837331056;14639.341229644479;14648.633784155481;13622.659433513845;13648.59054228335;13686.589402317946;14202.076865003743;14207.721305082592;11243.49404276826;11332.603358882729;11371.715707107389;11411.25826821254;11598.652040438801;9215.354925155443;9743;10405.093624058221;10968;11212.775744485229 08:10:26 INFO - PROCESS | 1638 | __end_tp_report 08:10:26 INFO - PROCESS | 1638 | __start_cc_report 08:10:26 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1547 08:10:26 INFO - PROCESS | 1638 | __end_cc_report 08:10:26 INFO - PROCESS | 1638 | __startTimestamp1484755826957__endTimestamp 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | ------- Summary: start ------- 08:10:26 INFO - PROCESS | 1638 | Number of tests: 6 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5751.12 Median:5911.23 stddev:661.33 (11.2%) stddev-sans-first:625.83 08:10:26 INFO - PROCESS | 1638 | Values: 2951.8 3378.5 3380.1 3389.7 3418.6 5589.6 5639.6 5667.6 5765.3 5766.4 5654.2 5698.0 5707.1 5712.6 5712.7 5193.4 5210.5 5235.2 5249.1 5292.9 5279.4 5285.2 5293.6 5296.2 5301.0 5287.7 5291.6 5295.1 5295.5 5298.3 5279.6 5280.1 5282.3 5284.9 5289.9 4296.5 5155.5 5241.1 5243.1 5246.2 5745.2 5772.5 5819.4 5894.4 5905.1 6312.3 6315.7 6328.0 6338.6 6350.5 5228.7 6223.3 6224.2 6250.3 6290.8 4893.7 5859.6 5870.4 5874.4 5901.7 6267.6 6291.4 6304.7 6307.5 6321.0 6069.0 6101.3 6123.4 6138.7 6144.4 6269.3 6290.3 6299.7 6300.7 6304.7 6161.1 6195.6 6260.5 6261.6 6264.3 6107.7 6146.3 6296.2 6308.4 6312.6 4413.5 4982.9 5022.2 5025.5 5056.5 4466.9 4469.7 4473.8 4495.1 4496.6 5616.4 5834.5 5839.9 5855.8 5858.0 5138.4 6214.2 6224.2 6270.6 6279.6 5853.6 5895.5 5904.1 5911.2 5928.4 5418.1 5446.5 5453.7 5492.2 5506.4 6330.0 6339.4 6353.1 6365.0 6396.1 6290.2 6302.2 6317.3 6320.3 6320.8 6208.4 6271.8 6326.6 6343.0 6438.2 6268.7 6280.8 6285.4 6285.9 6303.8 6170.0 6304.4 6316.1 6322.2 6325.6 5542.6 5749.5 5827.1 6175.9 6221.9 5993.3 6018.5 6059.0 6071.1 6122.6 5969.1 5991.5 5998.1 5999.8 6014.0 5207.3 6050.9 6107.6 6127.8 6131.6 5833.0 5877.1 5881.2 5943.0 6008.2 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:65700.61 Median:36302.23 stddev:136474.47 (375.9%) stddev-sans-first:136769.47 08:10:26 INFO - PROCESS | 1638 | Values: 482.0 501.2 503.0 504.6 522.9 28876.4 41523.6 43044.0 43078.6 45415.0 44411.3 44711.8 44821.6 44823.8 44832.7 8443.0 9278.2 9495.8 9510.1 9524.9 8466.3 11130.8 11384.3 11416.7 11610.8 11416.7 11475.6 11481.5 11504.5 11513.1 8438.7 8676.4 11387.4 11476.0 11481.4 11079.8 11400.3 11437.0 11565.8 11613.7 42398.0 42673.8 42782.6 42799.4 42840.6 3739.3 3858.4 4101.1 4107.8 4114.2 31209.5 31306.0 31645.7 31964.7 32640.8 3205.7 3205.8 3214.5 3250.5 3327.5 472211.0 474347.0 474535.0 474613.0 474885.0 66238.0 66632.3 66690.7 66743.7 66887.0 66367.7 68844.3 68975.3 69134.0 69209.7 15966.0 16563.7 16568.6 16596.0 16693.1 11392.9 11693.9 12611.7 12701.7 12732.9 16587.2 18423.6 18776.3 18885.0 19612.9 6632.4 6701.0 6765.6 6770.3 6781.4 763.7 839.5 857.9 878.2 882.4 29217.7 30442.7 30512.4 30636.8 31276.4 1057.7 1069.6 1098.4 1108.3 1217.2 15463.5 15665.1 15727.8 16089.0 16157.5 559846.0 564130.0 564687.0 564745.0 565559.0 63051.4 63086.1 63089.0 63119.4 63296.4 1278.0 1356.6 1367.1 1425.7 1436.1 28559.0 29075.1 29292.9 29697.0 29837.6 47978.8 48681.8 48700.0 48740.5 48785.0 494331.0 494783.0 496218.0 496411.0 498943.0 22617.9 23135.8 24993.6 25339.7 25359.5 36990.1 44544.6 44572.1 45465.8 47068.1 31905.4 34766.7 36175.0 36192.0 37260.1 35806.8 35995.0 36428.8 36696.4 36927.0 35324.3 35736.6 36412.5 36563.6 36564.1 30085.8 31301.1 31628.7 31715.5 32018.0 23430.5 23791.9 24104.4 24127.0 24179.8 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35554.21 Median:25595.99 stddev:95800.79 (374.3%) stddev-sans-first:96033.05 08:10:26 INFO - PROCESS | 1638 | Values: 342.7 352.4 389.0 395.7 422.8 15323.4 15842.2 19708.5 20964.0 21897.7 20627.7 20681.5 21173.6 21232.4 21423.8 5523.7 5833.4 5833.6 5837.3 5844.5 5540.5 5731.0 5733.3 5773.5 5786.9 5719.4 5727.1 5730.3 5741.6 5743.4 5234.6 5237.5 5563.7 5675.3 5729.8 4654.4 4803.7 4967.0 5030.9 5058.2 25226.6 25282.0 25288.9 25463.4 25728.6 2723.7 2750.7 2752.0 2752.9 2754.7 14823.4 15490.5 15506.5 15692.0 16044.8 1780.2 1798.3 1800.5 1817.4 1855.7 129514.0 129623.0 130182.0 130916.3 131058.8 10101.9 11292.3 11310.4 11508.5 11640.4 13162.2 13418.9 13560.7 14132.2 14156.6 8474.3 8549.9 8614.2 8622.7 8710.6 8473.4 8500.1 8505.7 8645.5 8709.3 6240.8 6641.8 7018.2 7039.2 7040.4 1862.6 1907.7 1909.7 1911.0 1911.2 337.3 1054.8 1054.9 1055.5 1106.1 11132.1 11502.9 11550.3 11902.3 12048.8 427.0 442.7 451.4 453.7 455.5 5676.2 6029.7 6051.9 6134.5 6154.6 527175.0 536116.0 571894.1 584967.0 589729.6 145856.0 153567.0 160691.0 162151.4 166849.0 1025.0 1035.4 1075.2 1081.6 1086.4 18904.6 19258.6 19544.7 19559.6 19581.4 58571.0 59442.7 59498.0 60650.1 61397.0 88855.0 91331.0 91984.0 92014.0 92404.0 8107.9 8351.5 8529.6 8622.9 8738.2 9591.8 12829.4 13388.3 13573.5 13594.9 11238.0 11349.4 11724.8 11787.6 11874.9 11281.2 11443.0 11486.3 11628.3 11833.1 9456.3 11672.6 11836.2 11891.9 11905.5 8051.4 8324.4 8428.9 8500.3 8765.3 10100.8 11287.3 11684.6 11707.5 11822.1 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5384.08 Median:5297.54 stddev:2919.83 (55.1%) stddev-sans-first:2911.57 08:10:26 INFO - PROCESS | 1638 | Values: 1259.5 1458.3 1472.5 1480.1 1491.7 8027.2 8422.5 8453.6 8466.1 8472.4 7337.4 7606.6 7612.5 8076.4 8175.0 2290.9 2329.3 2333.6 2335.2 2339.4 2286.0 2319.7 2321.4 2321.5 2331.9 2025.9 2098.1 2236.2 2292.3 2313.5 2312.2 2314.9 2319.2 2322.6 2326.8 2251.8 2305.0 2322.9 2326.3 2328.7 8279.8 8364.2 8364.9 8371.7 8378.9 5006.4 5123.2 5167.7 5178.2 5184.9 3321.0 3380.9 3416.3 3500.2 3523.2 1061.8 1139.1 1188.8 1219.2 1227.9 9690.3 9954.8 10665.3 10852.0 10860.3 4531.9 4588.6 4659.7 4661.5 4699.6 9508.4 9511.9 9514.2 9521.2 9533.5 5266.8 5274.3 5277.3 5293.4 5300.6 4246.6 4304.5 4735.8 4738.9 4810.2 3747.3 3801.2 3851.4 3872.8 3878.4 1248.3 1270.3 1272.2 1281.8 1282.9 777.0 837.8 903.2 903.7 935.5 5294.4 5406.1 5506.7 5622.7 5640.7 989.6 990.4 1024.2 1026.1 1050.6 3554.8 3657.9 3711.2 3782.5 3804.5 9699.1 9859.6 9983.8 9990.2 9995.7 9397.9 9722.2 9918.9 9930.5 9970.8 7491.3 7744.7 7744.8 7751.9 7806.0 5313.8 5408.3 5471.3 5484.6 5550.5 8518.2 8789.6 9263.2 9381.4 9399.6 9092.1 9180.9 9330.3 9364.4 9405.9 6349.0 6919.0 7145.3 7683.9 7811.9 7533.9 7798.5 7837.4 7927.0 7940.5 7020.5 7121.5 7142.8 7196.5 7266.7 6892.8 6947.5 6963.5 7050.5 7058.4 6192.5 6279.1 6310.7 6364.8 6372.9 4298.4 4822.3 4842.1 4879.6 4953.3 4046.4 4811.5 4923.2 4949.7 5076.9 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4372.03 Median:4838.19 stddev:1335.82 (27.6%) stddev-sans-first:1304.01 08:10:26 INFO - PROCESS | 1638 | Values: 293.0 315.8 349.9 367.2 367.9 4988.6 5204.8 5227.2 5266.6 5298.9 4286.7 5056.3 5067.7 5129.9 5203.8 3396.7 4099.2 4100.3 4105.9 4127.4 3452.0 3563.0 4050.1 4143.7 4145.7 4057.0 4086.9 4097.2 4099.4 4115.6 3636.7 4061.9 4061.9 4082.3 4093.3 3015.4 3422.9 3629.5 3635.2 3635.8 4235.9 4507.8 4920.5 5056.4 5153.8 4327.4 4686.0 4687.3 4690.0 4720.2 5011.9 5460.5 5476.3 5492.5 5499.6 3341.6 3345.6 3854.7 4008.7 4014.6 5427.3 5657.4 5736.0 5740.3 5761.9 3377.1 3562.8 3745.9 4074.6 4078.4 3625.7 4132.4 4135.9 4157.8 4160.8 3949.6 4463.7 4472.4 4496.9 4524.2 5426.0 5475.5 5493.5 5522.5 5536.6 1017.2 1139.8 1181.6 1190.0 1206.9 702.8 751.6 811.6 856.0 858.7 4504.5 4831.3 4836.4 4840.0 4910.9 4679.6 4807.3 5013.3 5401.6 5410.2 4180.5 4672.8 4785.2 4800.6 4860.9 2279.2 2468.6 2515.9 2822.2 2828.2 5338.3 5349.5 5567.4 5574.7 5608.9 4868.0 5428.5 5465.4 5475.5 5517.8 5286.3 5504.6 5512.7 5548.6 5560.9 4145.4 4612.8 5078.4 5320.0 5325.1 5235.7 5286.7 5297.9 5308.5 5308.7 4734.1 5458.0 5522.9 5535.0 5598.8 2997.6 3359.9 3521.3 3614.3 3691.9 4976.8 5584.3 5627.0 5632.7 5633.4 4687.7 5238.4 5340.9 5469.5 5518.4 4425.7 4812.5 5176.3 5305.0 5404.5 4642.6 4759.8 5067.9 5235.6 5272.8 4629.8 5025.6 5270.7 5499.9 5529.5 5372.3 5374.3 5378.9 5383.7 5398.6 08:10:26 INFO - PROCESS | 1638 | 08:10:26 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:19976.38 Median:24807.91 stddev:28213.65 (113.7%) stddev-sans-first:28255.76 08:10:26 INFO - PROCESS | 1638 | Values: 725.7 734.3 777.3 802.2 812.9 14468.4 15387.5 15416.8 15435.3 15438.5 14088.7 14226.1 14235.0 14257.9 14270.9 691.0 714.5 742.5 851.5 880.8 868.1 874.1 874.2 882.8 887.1 933.4 935.7 937.2 939.4 942.6 714.9 929.6 931.0 931.2 932.5 551.1 673.5 696.1 696.3 705.0 14697.4 14758.6 14763.6 14768.2 14833.6 13336.5 13470.2 13508.9 13589.2 13593.6 11961.6 12103.3 12267.8 12269.0 12466.6 3562.5 3662.8 3752.4 3856.4 3883.5 91305.0 93114.1 93824.5 96862.0 96985.0 10720.7 10770.9 10827.8 10893.8 10898.2 20313.5 20896.3 20928.7 20945.7 20962.4 7514.7 7571.9 7731.4 7734.4 7765.6 4251.2 4360.2 4364.4 4367.3 4496.8 3509.8 3518.3 3596.9 3665.2 3672.1 625.4 639.5 672.3 680.0 686.6 590.3 624.7 641.7 676.6 700.9 9708.7 9884.4 10274.9 10477.6 10657.3 573.3 577.0 609.4 645.5 705.8 4617.8 4670.8 5051.6 5057.4 5061.0 86555.0 104237.0 106300.5 106583.9 107732.0 88132.0 88665.0 88680.6 89263.7 92383.0 68723.7 76693.0 78208.6 78408.6 80341.6 9764.5 9771.6 9777.5 9779.4 9807.7 44998.0 46854.0 48023.0 48121.5 49361.5 57460.0 61772.7 65775.0 69186.7 69464.7 12170.5 12335.8 12668.9 12806.2 13653.2 14816.8 15014.2 15056.7 15158.4 15357.9 13860.4 13885.2 14158.5 14229.4 14534.4 13595.7 13937.3 14147.5 14639.3 14648.6 13622.7 13648.6 13686.6 14202.1 14207.7 11243.5 11332.6 11371.7 11411.3 11598.7 9215.4 9743.0 10405.1 10968.0 11212.8 08:10:26 INFO - PROCESS | 1638 | -------- Summary: end -------- 08:10:26 INFO - PROCESS | 1638 | 08:10:27 INFO - TEST-INFO | 1638: exit 0 08:10:27 INFO - TEST-OK | dromaeo_css | took 1118906ms 08:10:27 INFO - TEST-START | kraken 08:10:27 INFO - operating with platform_type : mac_ 08:10:27 INFO - Initialising browser for kraken test... 08:10:27 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmp3uQrZh/profile http://localhost:49238/getInfo.html) 08:10:30 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:10:30 INFO - PROCESS | 1647 | colorDepth:24 08:10:30 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:10:30 INFO - PROCESS | 1647 | __metrics 08:10:30 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:10:30 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:30 INFO - TEST-INFO | 1647: exit 0 08:10:30 INFO - Browser initialized. 08:10:30 INFO - Running cycle 1/1 for kraken test... 08:10:30 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmp3uQrZh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:42 INFO - PROCESS | 1648 | RSS: Main: 235282432 08:10:42 INFO - PROCESS | 1648 | 08:10:45 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 08:10:46 INFO - PROCESS | 1648 | RSS: Main: 288006144 08:10:46 INFO - PROCESS | 1648 | 08:10:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 08:10:49 INFO - PROCESS | 1648 | RSS: Main: 286765056 08:10:49 INFO - PROCESS | 1648 | 08:10:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 08:10:53 INFO - PROCESS | 1648 | RSS: Main: 378920960 08:10:53 INFO - PROCESS | 1648 | 08:10:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 08:10:56 INFO - PROCESS | 1648 | RSS: Main: 283029504 08:10:56 INFO - PROCESS | 1648 | 08:10:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:10:58 INFO - PROCESS | 1648 | RSS: Main: 286613504 08:10:58 INFO - PROCESS | 1648 | 08:11:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:02 INFO - PROCESS | 1648 | RSS: Main: 327589888 08:11:02 INFO - PROCESS | 1648 | 08:11:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:06 INFO - PROCESS | 1648 | RSS: Main: 331223040 08:11:06 INFO - PROCESS | 1648 | 08:11:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 08:11:09 INFO - PROCESS | 1648 | RSS: Main: 328044544 08:11:09 INFO - PROCESS | 1648 | 08:11:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:11 INFO - PROCESS | 1648 | RSS: Main: 303759360 08:11:11 INFO - PROCESS | 1648 | 08:11:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:11:14 INFO - PROCESS | 1648 | RSS: Main: 308510720 08:11:14 INFO - PROCESS | 1648 | 08:11:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:17 INFO - PROCESS | 1648 | RSS: Main: 309780480 08:11:17 INFO - PROCESS | 1648 | 08:11:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:20 INFO - PROCESS | 1648 | RSS: Main: 326696960 08:11:20 INFO - PROCESS | 1648 | 08:11:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:11:24 INFO - PROCESS | 1648 | RSS: Main: 320696320 08:11:24 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 08:11:26 INFO - PROCESS | 1648 | RSS: Main: 364642304 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | __start_tp_report 08:11:26 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 08:11:26 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 08:11:26 INFO - PROCESS | 1648 | |i|pagename|runs| 08:11:26 INFO - PROCESS | 1648 | |0;ai-astar;112;113;114;113;114;115;114;113;113;120 08:11:26 INFO - PROCESS | 1648 | |1;audio-beat-detection;142;109;110;169;138;109;108;109;129;109 08:11:26 INFO - PROCESS | 1648 | |2;audio-dft;184;183;186;184;186;181;182;182;183;183 08:11:26 INFO - PROCESS | 1648 | |3;audio-fft;84;58;59;85;61;58;58;58;64;59 08:11:26 INFO - PROCESS | 1648 | |4;audio-oscillator;90;71;83;69;69;68;81;67;69;84 08:11:26 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;121;130;89;85;87;85;89;84;87;84 08:11:26 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;93;94;115;92;93;107;126;139;149 08:11:26 INFO - PROCESS | 1648 | |7;imaging-desaturate;87;88;86;89;85;87;96;132;136;87 08:11:26 INFO - PROCESS | 1648 | |8;json-parse-financial;57;56;54;54;54;55;55;55;54;55 08:11:26 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;73;72;72;75;73;69;73;71;70;71 08:11:26 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;87;86;84;88;94;85;111;74;87;106 08:11:26 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;139;138;140;139;140;146;148;158;177;180 08:11:26 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;172;173;177;173;225;174;173;171;169;175 08:11:26 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;68;69;67;68;66;67;66;68;65 08:11:26 INFO - PROCESS | 1648 | __end_tp_report 08:11:26 INFO - PROCESS | 1648 | __start_cc_report 08:11:26 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1989 08:11:26 INFO - PROCESS | 1648 | __end_cc_report 08:11:26 INFO - PROCESS | 1648 | __startTimestamp1484755886458__endTimestamp 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | ------- Summary: start ------- 08:11:26 INFO - PROCESS | 1648 | Number of tests: 14 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:2.23 (2.0%) stddev-sans-first:2.24 08:11:26 INFO - PROCESS | 1648 | Values: 112.0 113.0 114.0 113.0 114.0 115.0 114.0 113.0 113.0 120.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:119.50 stddev:20.86 (17.5%) stddev-sans-first:20.98 08:11:26 INFO - PROCESS | 1648 | Values: 142.0 109.0 110.0 169.0 138.0 109.0 108.0 109.0 129.0 109.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.65 (0.9%) stddev-sans-first:1.73 08:11:26 INFO - PROCESS | 1648 | Values: 184.0 183.0 186.0 184.0 186.0 181.0 182.0 182.0 183.0 183.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:64.40 Median:60.00 stddev:10.76 (17.9%) stddev-sans-first:8.77 08:11:26 INFO - PROCESS | 1648 | Values: 84.0 58.0 59.0 85.0 61.0 58.0 58.0 58.0 64.0 59.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:8.45 (11.1%) stddev-sans-first:7.04 08:11:26 INFO - PROCESS | 1648 | Values: 90.0 71.0 83.0 69.0 69.0 68.0 81.0 67.0 69.0 84.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:86.00 stddev:16.78 (19.5%) stddev-sans-first:14.71 08:11:26 INFO - PROCESS | 1648 | Values: 121.0 130.0 89.0 85.0 87.0 85.0 89.0 84.0 87.0 84.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:110.10 Median:92.50 stddev:21.34 (23.1%) stddev-sans-first:21.72 08:11:26 INFO - PROCESS | 1648 | Values: 93.0 93.0 94.0 115.0 92.0 93.0 107.0 126.0 139.0 149.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:87.00 stddev:19.60 (22.5%) stddev-sans-first:20.43 08:11:26 INFO - PROCESS | 1648 | Values: 87.0 88.0 86.0 89.0 85.0 87.0 96.0 132.0 136.0 87.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:0.71 08:11:26 INFO - PROCESS | 1648 | Values: 57.0 56.0 54.0 54.0 54.0 55.0 55.0 55.0 54.0 55.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.50 stddev:1.73 (2.4%) stddev-sans-first:1.79 08:11:26 INFO - PROCESS | 1648 | Values: 73.0 72.0 72.0 75.0 73.0 69.0 73.0 71.0 70.0 71.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:86.50 stddev:10.89 (12.6%) stddev-sans-first:11.49 08:11:26 INFO - PROCESS | 1648 | Values: 87.0 86.0 84.0 88.0 94.0 85.0 111.0 74.0 87.0 106.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:147.00 stddev:15.97 (10.9%) stddev-sans-first:16.39 08:11:26 INFO - PROCESS | 1648 | Values: 139.0 138.0 140.0 139.0 140.0 146.0 148.0 158.0 177.0 180.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:173.50 stddev:16.59 (9.6%) stddev-sans-first:17.44 08:11:26 INFO - PROCESS | 1648 | Values: 172.0 173.0 177.0 173.0 225.0 174.0 173.0 171.0 169.0 175.0 08:11:26 INFO - PROCESS | 1648 | 08:11:26 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 08:11:26 INFO - PROCESS | 1648 | Values: 68.0 68.0 69.0 67.0 68.0 66.0 67.0 66.0 68.0 65.0 08:11:26 INFO - PROCESS | 1648 | -------- Summary: end -------- 08:11:26 INFO - PROCESS | 1648 | 08:11:27 INFO - TEST-INFO | 1648: exit 0 08:11:27 INFO - TEST-OK | kraken | took 59713ms 08:11:27 INFO - SUITE-END | took 1178s 08:11:27 INFO - Completed test suite (00:19:38) 08:11:27 INFO - javascript benchmark 08:11:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2951.7933744637858, 3378.5101160331747, 3380.0873764083713, 3389.694927456529, 3418.641042690517, 5589.636673616217, 5639.577031722617, 5667.631603945741, 5765.336986246578, 5766.394528574497, 5654.151877218419, 5697.974364614368, 5707.086866101425, 5712.600117991732, 5712.71436428179, 5193.376794784622, 5210.5310522053005, 5235.162374020158, 5249.055170069386, 5292.947070529303, 5279.445658205871, 5285.233641122035, 5293.6294459387855, 5296.2055691646365, 5301.0, 5287.709175995319, 5291.576673866081, 5295.0733621616255, 5295.496927791873, 5298.311219541454, 5279.63042587019, 5280.075986702331, 5282.313299271109, 5284.947150528523, 5289.894202115975, 4296.484421869396, 5155.536001759822, 5241.0828105081455, 5243.134882744343, 5246.160614301693, 5745.166950792153, 5772.538196944234, 5819.388964158745, 5894.3810899855325, 5905.143754155623, 6312.337204593543, 6315.74737010519, 6328.0, 6338.556301058928, 6350.460210882081, 5228.686278823245, 6223.315435302113, 6224.190855188796, 6250.281217659936, 6290.811275661737, 4893.73084480357, 5859.619124756962, 5870.354261031283, 5874.441928016831, 5901.734421951022, 6267.62394256346, 6291.433770960635, 6304.653244071528, 6307.5269354798575, 6320.968395157995, 6068.9696551517845, 6101.338204344246, 6123.4488895999575, 6138.7237574309265, 6144.4469997699525, 6269.279032911182, 6290.308066112724, 6299.685015749286, 6300.653464059521, 6304.747810087637, 6161.137440758297, 6195.566310358322, 6260.467860231931, 6261.5616906816085, 6264.342244064399, 6107.735039974563, 6146.340488068286, 6296.181496405529, 6308.369163083655, 6312.558120931582, 4413.492448368414, 4982.900341993212, 5022.2466630005065, 5025.547700706954, 5056.469070747518, 4466.932996005063, 4469.664775141812, 4473.821047158077, 4495.100979804052, 4496.617787488035, 5616.354119276336, 5834.545553839991, 5839.941600583939, 5855.765769369263, 5858.033424484997, 5138.3577052868395, 6214.161088253028, 6224.1597384352535, 6270.592411493239, 6279.623222606659, 5853.595266838976, 5895.469407753323, 5904.143899134601, 5911.231539899785, 5928.436798504135, 5418.051840927822, 5446.455354464601, 5453.672779633234, 5492.176173573996, 5506.394296627368, 6329.999999999908, 6339.429451349401, 6353.110564521063, 6365.045243213555, 6396.104545363746, 6290.182276304051, 6302.212223472066, 6317.305096439296, 6320.273168585672, 6320.841978950379, 6208.3791620839365, 6271.843203919756, 6326.588771729823, 6343.0485427186295, 6438.163038805113, 6268.717907694256, 6280.811575652738, 6285.402886725754, 6285.905711414424, 6303.842403939938, 6170.043643235305, 6304.369563043659, 6316.147320111726, 6322.178116844781, 6325.557210995186, 5542.63972841764, 5749.453801888814, 5827.096799996008, 6175.9073613894925, 6221.9377806221355, 5993.280806303272, 6018.4583387493585, 6059.0, 6071.058985857199, 6122.642120310999, 5969.134475501115, 5991.460768530853, 5998.1002849572915, 5999.820005399845, 6013.9699301503215, 5207.3230480037355, 6050.90923636137, 6107.633541987495, 6127.816165515042, 6131.601445906002, 5832.9708351457975, 5877.089051197071, 5881.235439392852, 5942.989691752326, 6008.24896887889], "value": 5708.709801077384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.99036019279635, 501.18557344315485, 502.9889921258271, 504.63666160364545, 522.8536009917225, 28876.422471550555, 41523.58476415235, 43044.0, 43078.56921430793, 45415.0, 44411.333829992494, 44711.77644111783, 44821.551784482144, 44823.77588112063, 44832.65502034944, 8442.957785211096, 9278.211352035085, 9495.81008379832, 9510.09654082861, 9524.904635966848, 8466.280366168883, 11130.833037504444, 11384.260023098472, 11416.71458213543, 11610.767784644302, 11416.657500275005, 11475.598354057609, 11481.483333250024, 11504.482298296554, 11513.136514761385, 8438.704645337384, 8676.436031657986, 11387.373694446802, 11476.0, 11481.425928703573, 11079.778404431947, 11400.315981041163, 11437.0, 11565.768684626344, 11613.709657258552, 42398.0, 42673.81229721704, 42782.57217427817, 42799.35800962988, 42840.57159428428, 3739.326921154191, 3858.421236814472, 4101.056756945889, 4107.774072426016, 4114.19773144237, 31209.531857022164, 31306.0, 31645.683543164505, 31964.680353196403, 32640.83679581587, 3205.743540516753, 3205.759568032407, 3214.5338925855854, 3250.5124231365485, 3327.517509961042, 472211.0, 474347.0, 474535.0, 474613.0, 474885.0, 66238.0, 66632.33367666358, 66690.66654666695, 66743.66628166828, 66887.0, 66367.66816165888, 68844.3115568838, 68975.31024689689, 69133.96299055518, 69209.65395173093, 15965.962212456154, 16563.66872662564, 16568.585785355463, 16596.0, 16693.081880496447, 11392.94303528477, 11693.941530292293, 12611.684707882376, 12701.745965080647, 12732.936335318263, 16587.170641467877, 18423.631527369376, 18776.342828000954, 18885.0, 19612.901935490518, 6632.436242919406, 6701.0, 6765.613049324877, 6770.255271920085, 6781.423578995742, 763.6678045050421, 839.4501601451059, 857.9056303806576, 878.2447095497866, 882.4352414454754, 29217.707822921922, 30442.695573044428, 30512.389752204832, 30636.846815765777, 31276.374472510877, 1057.6668349469892, 1069.6202847989007, 1098.4343063322394, 1108.3017698849835, 1217.2088142707312, 15463.5360939172, 15665.060096394252, 15727.764083538756, 16089.0, 16157.515274541782, 559846.0, 564130.0, 564687.0, 564745.0, 565559.0, 63051.36948630547, 63086.0537091944, 63089.0, 63119.36880631227, 63296.36703632997, 1277.9872201277867, 1356.647271709343, 1367.1387026173645, 1425.7148570285983, 1436.0665567381286, 28559.0, 29075.127746167647, 29292.853535732185, 29697.0, 29837.5524367139, 47978.80052998563, 48681.756591216814, 48700.0, 48740.512594875014, 48785.0, 494331.0, 494783.0, 496218.0, 496411.0, 498943.0, 22617.886910565343, 23135.76864231336, 24993.625095623946, 25339.746602533738, 25359.47843129418, 36990.07524811794, 44544.554554454044, 44572.10855782931, 45465.77267113643, 47068.058638827715, 31905.36189276155, 34766.65233347634, 36175.0, 36192.0, 37260.06849828776, 35806.82096589501, 35995.0, 36428.81785591161, 36696.449553257255, 36927.0, 35324.293514130084, 35736.642633573334, 36412.4538131923, 36563.63436365602, 36564.0858978517, 30085.849570752005, 31301.06096817099, 31628.678988705855, 31715.524267135548, 32018.0, 23430.531389371776, 23791.881040594686, 24104.39739006469, 24127.0, 24179.75820241775], "value": 19985.67111227723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6830182081575, 352.393882522062, 388.970827187961, 395.6874069485108, 422.78437996621716, 15323.38706451742, 15842.207889605532, 19708.507287317825, 20963.951802409894, 21897.671534926987, 20627.69058464124, 20681.482962925897, 21173.57652846942, 21232.40756943228, 21423.785762142375, 5523.7238138093035, 5833.387494313079, 5833.562482813806, 5837.299524057119, 5844.532437405019, 5540.529055030327, 5731.025725626653, 5733.283339582552, 5773.48038676519, 5786.884262314751, 5719.370869204384, 5727.11229759388, 5730.341010783772, 5741.569382296324, 5743.425657434244, 5234.607404444682, 5237.45006774289, 5563.693996830173, 5675.262215911946, 5729.82810515681, 4654.371659825948, 4803.703000189929, 4967.031428871372, 5030.949690503085, 5058.215976523645, 25226.621600676004, 25281.98872045116, 25288.873555632104, 25463.36341591475, 25728.614070788954, 2723.7412445817617, 2750.6699196096397, 2751.9724802752116, 2752.931176720578, 2754.6832114306712, 14823.407063717439, 15490.457833975757, 15506.5348039559, 15692.0, 16044.75932861008, 1780.2344991653583, 1798.3346161920174, 1800.4958611588777, 1817.400257914898, 1855.7123645834781, 129514.0, 129623.0, 130182.0, 130916.34541827325, 131058.79176645185, 10101.898981010096, 11292.322460652387, 11310.434478276053, 11508.482118304697, 11640.359780212, 13162.210267383987, 13418.93290533541, 13560.728785424237, 14132.222727750073, 14156.575302740934, 8474.27968622674, 8549.914500854911, 8614.22471977525, 8622.741317760352, 8710.564471776512, 8473.449225800303, 8500.064992850781, 8505.659773608986, 8645.481271123752, 8709.259712924346, 6240.81424529338, 6641.800745977628, 7018.1929078155645, 7039.1553013638695, 7040.3663670269925, 1862.6181632765251, 1907.6947688369794, 1909.7326374307331, 1911.0, 1911.235505797692, 337.31861639488096, 1054.8206804843196, 1054.915606751458, 1055.4775386183735, 1106.1095817866694, 11132.05377542918, 11502.94248528752, 11550.306981581132, 11902.285862848257, 12048.770977369215, 426.9594388533084, 442.69675272438485, 451.39513052509136, 453.68922288232005, 455.4944012146515, 5676.2393551934865, 6029.6683682397015, 6051.939480605226, 6134.539909506716, 6154.569180157346, 527175.0, 536116.0, 571894.1242350342, 584967.0, 589729.5648739275, 145856.0, 153567.0, 160691.0, 162151.37848621598, 166849.0, 1024.9846252306222, 1035.425338936882, 1075.2097208551866, 1081.6106201767357, 1086.4459125845876, 18904.621907562047, 19258.61482770365, 19544.706829397284, 19559.60880782405, 19581.412557622723, 58571.0, 59442.70278648579, 59498.0, 60650.09024864719, 61397.0, 88855.0, 91331.0, 91984.0, 92014.0, 92404.0, 8107.918920810952, 8351.498910065415, 8529.616167272612, 8622.913770862462, 8738.21356077956, 9591.808163836544, 12829.422675979416, 13388.330583470983, 13573.457061717421, 13594.932025340206, 11237.988581027746, 11349.432528373713, 11724.765504690029, 11787.587434439753, 11874.940625297164, 11281.153913456359, 11443.0, 11486.253393529394, 11628.302301861915, 11833.053355731692, 9456.338056336266, 11672.591459298883, 11836.171467997157, 11891.940540297242, 11905.523779049088, 8051.396145289244, 8324.417290789586, 8428.873566896624, 8500.277476414327, 8765.298776098025, 10100.84848727255, 11287.25553961261, 11684.649460516199, 11707.531698731955, 11822.11334149925], "value": 9440.89975335588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.5465632372347, 1458.343745314608, 1472.4772705689486, 1480.1341215389, 1491.7389456845062, 8027.237412445816, 8422.452540584858, 8453.57732113395, 8466.111058338878, 8472.449290796094, 7337.449691273163, 7606.619669016554, 7612.543247405146, 8076.434649574518, 8174.95912520438, 2290.874001929893, 2329.324495896188, 2333.556624241389, 2335.1710142899283, 2339.3800642829665, 2285.954280914381, 2319.6636487709357, 2321.442853715113, 2321.4776675248104, 2331.9300420987397, 2025.8885761283123, 2098.1187901081585, 2236.1837929155904, 2292.3123063081093, 2313.467902382453, 2312.1791763923816, 2314.9421264468356, 2319.1998760427628, 2322.628379459278, 2326.8254880883915, 2251.8311126665403, 2304.976950230493, 2322.93031209064, 2326.302109367183, 2328.732195797488, 8279.751607451786, 8364.247217750371, 8364.916350836475, 8371.706990255372, 8378.874316885252, 5006.4492905780335, 5123.2315152727015, 5167.656409333563, 5178.197379406198, 5184.922226166611, 3320.9833950830093, 3380.8816691415927, 3416.3167366526545, 3500.177458297298, 3523.1720545671747, 1061.8354155105972, 1139.0944199361527, 1188.8335633011386, 1219.1892391559602, 1227.9201851879689, 9690.273229507815, 9954.755655543056, 10665.253432259746, 10852.023317901427, 10860.348379097279, 4531.864044078683, 4588.632909367243, 4659.697119687209, 4661.487236403993, 4699.577038066522, 9508.429494230368, 9511.857322140173, 9514.238860891111, 9521.190698790542, 9533.52332383378, 5266.789328426897, 5274.26160337553, 5277.2875661785165, 5293.3647962244, 5300.628955973122, 4246.554111818276, 4304.461942257218, 4735.763211839394, 4738.905221895543, 4810.230363141881, 3747.2880152770886, 3801.201747633028, 3851.4030325299623, 3872.8257228424786, 3878.3600705883778, 1248.2884755689352, 1270.314030423561, 1272.204871955028, 1281.814136950137, 1282.9166104203198, 776.9883451748228, 837.7989282572139, 903.1916434790957, 903.7153296711515, 935.4948327902856, 5294.444083371268, 5406.053940560386, 5506.712605441324, 5622.690752008597, 5640.661560306395, 989.6091044037709, 990.3513198854762, 1024.1857723110145, 1026.1124127629546, 1050.632278702448, 3554.8222588870453, 3657.8902632921054, 3711.183539621279, 3782.527184101987, 3804.4673745675627, 9699.127078562964, 9859.556319965619, 9983.800323993479, 9990.200783937413, 9995.70012899614, 9397.859032114524, 9722.173615242642, 9918.900810991941, 9930.453825039693, 9970.800583988279, 7491.250874912465, 7744.728934487266, 7744.7676569703, 7751.883721744179, 7805.960970195113, 5313.760880760297, 5408.296921400193, 5471.316085489314, 5484.643498172606, 5550.5282051026115, 8518.23335899772, 8789.560521974003, 9263.16631503168, 9381.390209636353, 9399.624015039595, 9092.090790920854, 9180.862287065833, 9330.253579713743, 9364.438133712, 9405.905940940504, 6349.015902534929, 6919.0, 7145.321194486515, 7683.884741728991, 7811.921880781347, 7533.886991695019, 7798.532088074734, 7837.373010159287, 7926.960365198137, 7940.523568585903, 7020.508564400443, 7121.501494895515, 7142.785716428515, 7196.496245262991, 7266.7093316266755, 6892.758753443605, 6947.548409353376, 6963.4777391694815, 7050.541714788523, 7058.364747172779, 6192.535559833121, 6279.089532017741, 6310.652914089769, 6364.77723279683, 6372.904406433814, 4298.376735373416, 4822.348982887405, 4842.128416884994, 4879.56083952446, 4953.281774142802, 4046.4132700758814, 4811.542903424169, 4923.236898280772, 4949.653524253267, 5076.873078172927], "value": 4389.800948070683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.9604503392042, 315.8231390421364, 349.882789265596, 367.23431645020133, 367.9172186258092, 4988.551030407262, 5204.817831375903, 5227.215917612355, 5266.603041038527, 5298.867528311789, 4286.678499112563, 5056.292119103319, 5067.668872318738, 5129.9227162295965, 5203.843884683456, 3396.677315655021, 4099.24164029654, 4100.343944968806, 4105.876823695294, 4127.422160897469, 3451.982740086296, 3563.0, 4050.1494686115952, 4143.689223308249, 4145.730527515701, 4057.0, 4086.8569600064, 4097.180563887219, 4099.44657471242, 4115.567865374138, 3636.6726994570618, 4061.8626784500534, 4061.8829821799095, 4082.2856000199845, 4093.3450647896193, 3015.3969206158636, 3422.863085476578, 3629.510016147839, 3635.2184280379847, 3635.763675361093, 4235.87292381226, 4507.842225522091, 4920.532549407801, 5056.418511871145, 5153.793848246066, 4327.350897365389, 4685.976570117127, 4687.273472611751, 4689.95310046902, 4720.244760838249, 5011.899762004739, 5460.453954604547, 5476.288082549243, 5492.533134683556, 5499.642523235977, 3341.599008119041, 3345.631980482145, 3854.7494412863075, 4008.67930565557, 4014.638682518558, 5427.294451721251, 5657.405972372882, 5736.024875771129, 5740.282464691913, 5761.88476230473, 3377.071305391037, 3562.7886518583805, 3745.9438108428394, 4074.5925407459017, 4078.3678529827926, 3625.655562721537, 4132.380142978577, 4135.937960930589, 4157.812898419578, 4160.771157586301, 3949.565547789741, 4463.66522510813, 4472.39622650938, 4496.887577810581, 4524.185646583646, 5425.972870135624, 5475.4524547544925, 5493.533049690741, 5522.502974732293, 5536.61584603849, 1017.1659239423601, 1139.7777433400572, 1181.5687274144875, 1190.0, 1206.9155159138952, 702.7891632510226, 751.5791156952124, 811.6185392865344, 855.9529225892636, 858.6694122762781, 4504.459464864237, 4831.251156070814, 4836.395450568679, 4839.975800120977, 4910.852674419773, 4679.64902632304, 4807.326974223612, 5013.298138260647, 5401.621886467988, 5410.185818997597, 4180.540140584533, 4672.766361681903, 4785.186518291899, 4800.559832050371, 4860.927086093711, 2279.202279202299, 2468.568000599888, 2515.9119430819833, 2822.20978126125, 2828.1939647200447, 5338.279332290169, 5349.53929059608, 5567.409021181315, 5574.721263936868, 5608.9439105609235, 4867.977724677787, 5428.4842939920645, 5465.4261302563455, 5475.534579560703, 5517.751701173376, 5286.286351342596, 5504.559635229252, 5512.724363781795, 5548.55611551083, 5560.860978475571, 4145.357469592218, 4612.769361531977, 5078.410010894397, 5319.973400132974, 5325.124432806241, 5235.712035838065, 5286.70028537572, 5297.867553311198, 5308.46915308466, 5308.734563271898, 4734.124187025412, 5457.972710136424, 5522.889542209214, 5534.972325138348, 5598.832035038955, 2997.6252968378953, 3359.8656053757577, 3521.2605352875157, 3614.2771445711487, 3691.8892433227047, 4976.765102683285, 5584.274044374205, 5626.971865140648, 5632.662040277596, 5633.436656334334, 4687.742174180453, 5238.449962753856, 5340.919886201787, 5469.507744302873, 5518.392976772471, 4425.734455932655, 4812.5215514009615, 5176.3011993381915, 5304.965531721277, 5404.459554044564, 4642.558956899089, 4759.833405830779, 5067.87330316745, 5235.58639167415, 5272.815451459181, 4629.8471210885755, 5025.562602137887, 5270.73646317675, 5499.890002199853, 5529.502344788988, 5372.301600791872, 5374.280230326258, 5378.858279124974, 5383.650062745909, 5398.64908780928], "value": 3945.4586388805096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6698202317949, 734.2840730287967, 777.3392616276166, 802.2227634436928, 812.9154419236354, 14468.421263149474, 15387.461438849643, 15416.845831541681, 15435.305411256493, 15438.459653912116, 14088.71822563548, 14226.075305105162, 14235.0, 14257.857421425782, 14270.857291427083, 691.0463560286822, 714.4641518860855, 742.4876834983844, 851.5444237333028, 880.8194320164367, 868.1405408645459, 874.0778478704964, 874.1695389380114, 882.7528292078229, 887.1261807119981, 933.3932943586655, 935.6865450074233, 937.1659223291276, 939.4034787909692, 942.5664194470552, 714.935655790976, 929.586334081334, 930.9627614895396, 931.1805611062256, 932.5290728182292, 551.1127085392515, 673.4746897419972, 696.1298377028714, 696.2793508718503, 704.9964750176267, 14697.412103515846, 14758.631034224123, 14763.630909227248, 14768.187749673763, 14833.554993350217, 13336.466541338335, 13470.191788492624, 13508.91928645706, 13589.184648920998, 13593.59219223425, 11961.581344652895, 12103.273803571814, 12267.754644907141, 12268.957138643225, 12466.626001219978, 3562.5190599269285, 3662.7729710547, 3752.4371344298575, 3856.3636999895266, 3883.475730776337, 91305.0, 93114.06885931121, 93824.53087734585, 96862.03137968671, 96985.0301496983, 10720.678379648467, 10770.892291077145, 10827.83758243627, 10893.782124357469, 10898.18263630215, 20313.492162695755, 20896.268630597857, 20928.686069708965, 20945.685814712793, 20962.371128866158, 7514.6618402172035, 7571.924280757122, 7731.381489480828, 7734.381249500027, 7765.572893490912, 4251.17102165081, 4360.193364227564, 4364.367166760802, 4367.323064924942, 4496.775161241991, 3509.754317197772, 3518.2963407318125, 3596.892093237207, 3665.193657395369, 3672.0636237759736, 625.3621306267581, 639.5491178718992, 672.3444641474621, 680.0, 686.5983399711125, 590.3034419385167, 624.6689254695019, 641.7176442365344, 676.6008055247428, 700.9018737376771, 9708.660196893215, 9884.357516761387, 10274.897251027394, 10477.580896764197, 10657.25399222047, 573.3005733005726, 576.9942300577025, 609.3906093906094, 645.4642646603309, 705.7741522712786, 4617.8152873884665, 4670.813167473331, 5051.621128415383, 5057.367829021372, 5060.974695126574, 86555.0, 104237.0, 106300.46849765857, 106583.93416065896, 107732.0, 88132.0, 88665.0, 88680.55659721661, 89263.66104508437, 92383.0, 68723.65638171877, 76692.99999999888, 78208.60895695485, 78408.60795695985, 80341.59829200816, 9764.462954537285, 9771.560279787569, 9777.511124443892, 9779.41323520591, 9807.656732014346, 44998.0, 46854.0, 48023.0, 48121.518784811706, 49361.50638493569, 57460.0, 61772.69113654403, 65775.0, 69186.65406672934, 69464.6526767363, 12170.45232964501, 12335.75328493443, 12668.936655316664, 12806.231626102464, 13653.249071301174, 14816.777748334, 15014.249287535798, 15056.698866022838, 15158.393664253748, 15357.923210383877, 13860.41728033889, 13885.166889986633, 14158.50445234412, 14229.430822766974, 14534.418623255375, 13595.728085438433, 13937.30313484342, 14147.504837331056, 14639.341229644479, 14648.633784155481, 13622.659433513845, 13648.59054228335, 13686.589402317946, 14202.076865003743, 14207.721305082592, 11243.49404276826, 11332.603358882729, 11371.715707107389, 11411.25826821254, 11598.652040438801, 9215.354925155443, 9743.0, 10405.093624058221, 10968.0, 11212.775744485229], "value": 7457.1576682071645, "unit": "score"}], "name": "dromaeo_css", "value": 7198.452300078089, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 113.0, 120.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 169.0, 138.0, 109.0, 108.0, 109.0, 129.0, 109.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 184.0, 186.0, 181.0, 182.0, 182.0, 183.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 85.0, 61.0, 58.0, 58.0, 58.0, 64.0, 59.0], "value": 64.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 83.0, 69.0, 69.0, 68.0, 81.0, 67.0, 69.0, 84.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 130.0, 89.0, 85.0, 87.0, 85.0, 89.0, 84.0, 87.0, 84.0], "value": 94.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 115.0, 92.0, 93.0, 107.0, 126.0, 139.0, 149.0], "value": 110.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 89.0, 85.0, 87.0, 96.0, 132.0, 136.0, 87.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 75.0, 73.0, 69.0, 73.0, 71.0, 70.0, 71.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 88.0, 94.0, 85.0, 111.0, 74.0, 87.0, 106.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 140.0, 139.0, 140.0, 146.0, 148.0, 158.0, 177.0, 180.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 177.0, 173.0, 225.0, 174.0, 173.0, 171.0, 169.0, 175.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 68.0, 66.0, 67.0, 66.0, 68.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1474.6000000000001, "alertThreshold": 2.0}]} 08:11:27 INFO - Return code: 0 08:11:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:11:27 ERROR - # TBPL SUCCESS # 08:11:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:27 INFO - 2017-01-18 08:11:27.763 screenresolution[1652:9712] starting screenresolution argv=screenresolution get 08:11:27 INFO - 2017-01-18 08:11:27.766 screenresolution[1652:9712] Display 0: 1600x1200x32@60 08:11:27 INFO - 2017-01-18 08:11:27.773 screenresolution[1653:9716] starting screenresolution argv=screenresolution list 08:11:27 INFO - Available Modes on Display 0 08:11:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:28 INFO - Intel Iris: 08:11:28 INFO - Chipset Model: Intel Iris 08:11:28 INFO - Type: GPU 08:11:28 INFO - Bus: Built-In 08:11:28 INFO - VRAM (Dynamic, Max): 1536 MB 08:11:28 INFO - Vendor: Intel (0x8086) 08:11:28 INFO - Device ID: 0x0a2e 08:11:28 INFO - Revision ID: 0x0009 08:11:28 INFO - Displays: 08:11:28 INFO - Display: 08:11:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:28 INFO - Display Serial Number: 1600x1200 60 08:11:28 INFO - Main Display: Yes 08:11:28 INFO - Mirror: Off 08:11:28 INFO - Online: Yes 08:11:28 INFO - Rotation: Supported 08:11:28 INFO - Return code: 0 08:11:28 INFO - Running post-action listener: _resource_record_post_action 08:11:28 INFO - [mozharness: 2017-01-18 16:11:28.008030Z] Finished run-tests step (success) 08:11:28 INFO - Running post-run listener: _resource_record_post_run 08:11:28 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37704704; Write bytes: 552464896; Read time: 241; Write time: 1638 08:11:28 INFO - TinderboxPrint: CPU usage
53.8% 08:11:28 INFO - TinderboxPrint: I/O read bytes / time
37,704,704 / 241 08:11:28 INFO - TinderboxPrint: I/O write bytes / time
552,464,896 / 1,638 08:11:28 INFO - TinderboxPrint: CPU idle
2,222.5 (46.2%) 08:11:28 INFO - TinderboxPrint: CPU system
963.0 (20.0%) 08:11:28 INFO - TinderboxPrint: CPU user
1,620.1 (33.7%) 08:11:28 INFO - TinderboxPrint: Swap in / out
288,325,632 / 0 08:11:28 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 247046656; Write bytes: 239937536; Read time: 17836; Write time: 504 08:11:28 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35582976; Write bytes: 296765952; Read time: 218; Write time: 1096 08:11:28 INFO - Running post-run listener: _upload_blobber_files 08:11:28 INFO - Blob upload gear active. 08:11:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:11:28 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:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:11:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:30 INFO - (blobuploader) - INFO - Done attempting. 08:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:31 INFO - (blobuploader) - INFO - Done attempting. 08:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:33 INFO - (blobuploader) - INFO - Done attempting. 08:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:35 INFO - (blobuploader) - INFO - Done attempting. 08:11:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:11:35 INFO - Return code: 0 08:11:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:11:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:11:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ece1aeda8f6fb5e62ffe2c8f699e87bb1480d2bf7a76557fff4a3684af2a65cacbae8a4f9c3bbe124a0db5320980a1f455a0ab30983eca13224b5978475832c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79337ac254a359575bdfe3da045d467955d00de10eab5c5a0224fc1052f06c83535fc88ef4f69f0502e8815e02164ebf93f294b671cea039c3a4e6ddb619d4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06b205f8ef97ba9df3f61a3da3200bef877653617647706e832c14e882cd1bc3446fa2c4ad15a4e8219f6b6f3f33d42acd1f5eddf704edcb399ade9ba85feb56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99d9084353869e0a2ecf9951715a3f0640a50334098cfb777fd1999b12f7fdf36b60c4ad08e1f87af306f0f26eb8aa5d9a3d1f0ee9cd86b48dd699f9feb0767f"} 08:11:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:11:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:11:35 INFO - Contents: 08:11:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ece1aeda8f6fb5e62ffe2c8f699e87bb1480d2bf7a76557fff4a3684af2a65cacbae8a4f9c3bbe124a0db5320980a1f455a0ab30983eca13224b5978475832c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79337ac254a359575bdfe3da045d467955d00de10eab5c5a0224fc1052f06c83535fc88ef4f69f0502e8815e02164ebf93f294b671cea039c3a4e6ddb619d4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06b205f8ef97ba9df3f61a3da3200bef877653617647706e832c14e882cd1bc3446fa2c4ad15a4e8219f6b6f3f33d42acd1f5eddf704edcb399ade9ba85feb56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99d9084353869e0a2ecf9951715a3f0640a50334098cfb777fd1999b12f7fdf36b60c4ad08e1f87af306f0f26eb8aa5d9a3d1f0ee9cd86b48dd699f9feb0767f"} 08:11:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:11:35 INFO - Copying logs to upload dir... 08:11:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:11:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.554771 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-01-18 08:11:35.766153) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:11:35.769206) ========= 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.rM41kX1Eer/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.VgfOeDRhKq/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ece1aeda8f6fb5e62ffe2c8f699e87bb1480d2bf7a76557fff4a3684af2a65cacbae8a4f9c3bbe124a0db5320980a1f455a0ab30983eca13224b5978475832c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79337ac254a359575bdfe3da045d467955d00de10eab5c5a0224fc1052f06c83535fc88ef4f69f0502e8815e02164ebf93f294b671cea039c3a4e6ddb619d4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06b205f8ef97ba9df3f61a3da3200bef877653617647706e832c14e882cd1bc3446fa2c4ad15a4e8219f6b6f3f33d42acd1f5eddf704edcb399ade9ba85feb56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99d9084353869e0a2ecf9951715a3f0640a50334098cfb777fd1999b12f7fdf36b60c4ad08e1f87af306f0f26eb8aa5d9a3d1f0ee9cd86b48dd699f9feb0767f"} build_url:https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/Dh_7hCJcSaKDLW2E__eTwQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ece1aeda8f6fb5e62ffe2c8f699e87bb1480d2bf7a76557fff4a3684af2a65cacbae8a4f9c3bbe124a0db5320980a1f455a0ab30983eca13224b5978475832c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79337ac254a359575bdfe3da045d467955d00de10eab5c5a0224fc1052f06c83535fc88ef4f69f0502e8815e02164ebf93f294b671cea039c3a4e6ddb619d4d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06b205f8ef97ba9df3f61a3da3200bef877653617647706e832c14e882cd1bc3446fa2c4ad15a4e8219f6b6f3f33d42acd1f5eddf704edcb399ade9ba85feb56", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99d9084353869e0a2ecf9951715a3f0640a50334098cfb777fd1999b12f7fdf36b60c4ad08e1f87af306f0f26eb8aa5d9a3d1f0ee9cd86b48dd699f9feb0767f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:11:35.804485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:11:35.804875) ========= 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.rM41kX1Eer/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.VgfOeDRhKq/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:11:35.853618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:11:35.853942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:11:35.854280) ========= ========= Total master_lag: 1.02 =========