builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1491603988.45 results: success (0) buildid: 20170407135522 builduid: 8ccf87c621a940ceb954f2bcf7fac778 revision: b4c7f4163f3e9d8a3652d80615037434c04682c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.448541) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.449006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.449286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.476123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.476559) ========= 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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-04-07 15:26:28-- 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% 15.2M=0.001s 2017-04-07 15:26:28 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150450 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.654039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.654632) ========= 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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.027809 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:28.706793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 15:26:28.707164) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b4c7f4163f3e9d8a3652d80615037434c04682c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b4c7f4163f3e9d8a3652d80615037434c04682c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNxKuDeWbz/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.R9Chz6SMmO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-04-07 15:26:28,793 truncating revision to first 12 chars 2017-04-07 15:26:28,793 Setting DEBUG logging. 2017-04-07 15:26:28,793 attempt 1/10 2017-04-07 15:26:28,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b4c7f4163f3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 15:26:30,528 unpacking tar archive at: mozilla-beta-b4c7f4163f3e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.011965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 15:26:30.740402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:30.740776) ========= script_repo_revision: b4c7f4163f3e9d8a3652d80615037434c04682c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:30.741217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:30.741518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 15:26:30.761784) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-04-07 15:26:30.762191) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lNxKuDeWbz/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.R9Chz6SMmO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:26:30 INFO - MultiFileLogger online at 20170407 15:26:30 in /builds/slave/test 15:26:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:26:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:30 INFO - {'append_to_log': False, 15:26:30 INFO - 'base_work_dir': '/builds/slave/test', 15:26:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:26:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:30 INFO - 'branch': 'Mozilla-Beta', 15:26:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:30 INFO - 'config_files': ('talos/mac_config.py',), 15:26:30 INFO - 'default_actions': ('clobber', 15:26:30 INFO - 'read-buildbot-config', 15:26:30 INFO - 'download-and-extract', 15:26:30 INFO - 'populate-webroot', 15:26:30 INFO - 'create-virtualenv', 15:26:30 INFO - 'install', 15:26:30 INFO - 'run-tests'), 15:26:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:30 INFO - 'download_minidump_stackwalk': True, 15:26:30 INFO - 'download_symbols': 'ondemand', 15:26:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:30 INFO - 'installer_path': 'installer.exe', 15:26:30 INFO - 'log_level': 'info', 15:26:30 INFO - 'log_name': 'talos', 15:26:30 INFO - 'log_to_console': True, 15:26:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:26:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:26:30 INFO - 'opt_config_files': (), 15:26:30 INFO - 'pip_index': False, 15:26:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:30 INFO - 'cmd': ('bash', 15:26:30 INFO - '-c', 15:26:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:30 INFO - 'enabled': True, 15:26:30 INFO - 'halt_on_failure': False, 15:26:30 INFO - 'name': 'check_screen_resolution'},), 15:26:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:30 INFO - 'cmd': ('bash', 15:26:30 INFO - '-c', 15:26:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:30 INFO - 'enabled': True, 15:26:30 INFO - 'halt_on_failure': False, 15:26:30 INFO - 'name': 'check_screen_resolution'},), 15:26:30 INFO - 'run_cmd_checks_enabled': True, 15:26:30 INFO - 'sps_profile': False, 15:26:30 INFO - 'sps_profile_interval': 0, 15:26:30 INFO - 'suite': 'dromaeojs', 15:26:30 INFO - 'system_bits': '32', 15:26:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:30 INFO - 'title': 't-yosemite-r7-0180', 15:26:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:30 INFO - 'use_talos_json': True, 15:26:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:30 INFO - 'work_dir': 'build'} 15:26:30 INFO - [mozharness: 2017-04-07 22:26:30.963667Z] Running clobber step. 15:26:30 INFO - Running pre-action listener: _resource_record_pre_action 15:26:30 INFO - Running main action method: clobber 15:26:30 INFO - rmtree: /builds/slave/test/build 15:26:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:33 INFO - Running post-action listener: _resource_record_post_action 15:26:33 INFO - [mozharness: 2017-04-07 22:26:33.353529Z] Finished clobber step (success) 15:26:33 INFO - [mozharness: 2017-04-07 22:26:33.353773Z] Running read-buildbot-config step. 15:26:33 INFO - Running pre-action listener: _resource_record_pre_action 15:26:33 INFO - Running main action method: read_buildbot_config 15:26:33 INFO - Using buildbot properties: 15:26:33 INFO - { 15:26:33 INFO - "project": "", 15:26:33 INFO - "product": "firefox", 15:26:33 INFO - "script_repo_revision": "production", 15:26:33 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:26:33 INFO - "repository": "", 15:26:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:26:33 INFO - "buildid": "20170407135522", 15:26:33 INFO - "pgo_build": "False", 15:26:33 INFO - "basedir": "/builds/slave/test", 15:26:33 INFO - "buildnumber": 16, 15:26:33 INFO - "slavename": "t-yosemite-r7-0180", 15:26:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:26:33 INFO - "platform": "yosemite_r7", 15:26:33 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:26:33 INFO - "branch": "mozilla-beta", 15:26:33 INFO - "repo_path": "releases/mozilla-beta", 15:26:33 INFO - "revision": "b4c7f4163f3e9d8a3652d80615037434c04682c1", 15:26:33 INFO - "stage_platform": "macosx64", 15:26:33 INFO - "builduid": "8ccf87c621a940ceb954f2bcf7fac778", 15:26:33 INFO - "slavebuilddir": "test" 15:26:33 INFO - } 15:26:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:26:33 INFO - Running post-action listener: _resource_record_post_action 15:26:33 INFO - [mozharness: 2017-04-07 22:26:33.357065Z] Finished read-buildbot-config step (success) 15:26:33 INFO - [mozharness: 2017-04-07 22:26:33.357178Z] Running download-and-extract step. 15:26:33 INFO - Running pre-action listener: _resource_record_pre_action 15:26:33 INFO - Running main action method: download_and_extract 15:26:33 INFO - mkdir: /builds/slave/test/build/tests 15:26:33 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')]} 15:26:33 INFO - trying https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:26:33 INFO - Downloading https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:26:34 INFO - Downloaded 1165 bytes. 15:26:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:26:34 INFO - Using the following test package requirements: 15:26:34 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:26:34 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:26:34 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:26:34 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:26:34 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:26:34 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:26:34 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:26:34 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:26:34 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:26:34 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:26:34 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:26:34 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:26:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:26:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:26:34 INFO - Fetch https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:26:35 INFO - Expected file size: 16116448 15:26:35 INFO - Obtained file size: 16116448 15:26:41 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:26:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:26:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:26:41 INFO - Fetch https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:26:42 INFO - Expected file size: 16116448 15:26:42 INFO - Obtained file size: 16116448 15:26:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:26:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:26:49 INFO - Fetch https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:26:50 INFO - Expected file size: 14403650 15:26:50 INFO - Obtained file size: 14403650 15:26:50 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')]} 15:26:50 INFO - trying https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:26:50 INFO - Downloading https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:26:52 INFO - Downloaded 58735175 bytes. 15:26:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:26:52 INFO - mkdir: /builds/slave/test/properties 15:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:52 INFO - Contents: 15:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:26:53 INFO - Running post-action listener: _resource_record_post_action 15:26:53 INFO - Running post-action listener: set_extra_try_arguments 15:26:53 INFO - [mozharness: 2017-04-07 22:26:53.040857Z] Finished download-and-extract step (success) 15:26:53 INFO - [mozharness: 2017-04-07 22:26:53.041011Z] Running populate-webroot step. 15:26:53 INFO - Running pre-action listener: _resource_record_pre_action 15:26:53 INFO - Running main action method: populate_webroot 15:26:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:53 INFO - '--tppagecycles', 15:26:53 INFO - '7'], 15:26:53 INFO - 'tests': ['tsvgm']}}, 15:26:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['damp', 'tps']}, 15:26:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'tests': ['damp', 'tps']}, 15:26:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['dromaeo_dom']}, 15:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['basic_compositor_video']}, 15:26:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:26:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['a11yr', 15:26:53 INFO - 'ts_paint', 15:26:53 INFO - 'tpaint', 15:26:53 INFO - 'sessionrestore', 15:26:53 INFO - 'sessionrestore_no_auto_restore', 15:26:53 INFO - 'tabpaint']}, 15:26:53 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:53 INFO - 'ts_paint', 15:26:53 INFO - 'tpaint', 15:26:53 INFO - 'sessionrestore', 15:26:53 INFO - 'sessionrestore_no_auto_restore', 15:26:53 INFO - 'tabpaint']}, 15:26:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:53 INFO - 'ts_paint', 15:26:53 INFO - 'tpaint', 15:26:53 INFO - 'sessionrestore', 15:26:53 INFO - 'sessionrestore_no_auto_restore', 15:26:53 INFO - 'tabpaint']}, 15:26:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:53 INFO - 'ts_paint', 15:26:53 INFO - 'tpaint', 15:26:53 INFO - 'sessionrestore', 15:26:53 INFO - 'sessionrestore_no_auto_restore', 15:26:53 INFO - 'tabpaint']}, 15:26:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['a11yr', 15:26:53 INFO - 'ts_paint', 15:26:53 INFO - 'tpaint', 15:26:53 INFO - 'sessionrestore', 15:26:53 INFO - 'sessionrestore_no_auto_restore', 15:26:53 INFO - 'tabpaint']}, 15:26:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['a11yr', 15:26:53 INFO - 'ts_paint', 15:26:53 INFO - 'tpaint', 15:26:53 INFO - 'sessionrestore', 15:26:53 INFO - 'sessionrestore_no_auto_restore', 15:26:53 INFO - 'tabpaint']}, 15:26:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['tsvgx', 15:26:53 INFO - 'tsvgr_opacity', 15:26:53 INFO - 'tart', 15:26:53 INFO - 'tscrollx', 15:26:53 INFO - 'cart', 15:26:53 INFO - 'tsvg_static']}, 15:26:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:53 INFO - 'tsvgr_opacity', 15:26:53 INFO - 'tart', 15:26:53 INFO - 'tscrollx', 15:26:53 INFO - 'cart', 15:26:53 INFO - 'tsvg_static']}, 15:26:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'talos_options': ['--disable-e10s'], 15:26:53 INFO - 'tests': ['tp5o']}, 15:26:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:26:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'talos_options': ['--disable-e10s', 15:26:53 INFO - '--xperf_path', 15:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:53 INFO - 'tests': ['tp5n']}, 15:26:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:26:53 INFO - 'talos_options': ['--xperf_path', 15:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:53 INFO - 'tests': ['tp5n']}}, 15:26:53 INFO - 'talos.zip': {'path': '', 15:26:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:53 INFO - Running post-action listener: _resource_record_post_action 15:26:53 INFO - [mozharness: 2017-04-07 22:26:53.059297Z] Finished populate-webroot step (success) 15:26:53 INFO - [mozharness: 2017-04-07 22:26:53.059419Z] Running create-virtualenv step. 15:26:53 INFO - Running pre-action listener: _resource_record_pre_action 15:26:53 INFO - Running main action method: create_virtualenv 15:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:53 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 15:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:53 INFO - Using real prefix '/tools/python27' 15:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:53 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:56 INFO - Installing pip.................done. 15:26:56 INFO - Return code: 0 15:26:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:26:57 INFO - Reading from file tmpfile_stdout 15:26:57 INFO - Output received: 15:26:57 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) 15:26:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:57 INFO - 'HOME': '/Users/cltbld', 15:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PAGER': '/bin/cat', 15:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:26:57 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - 'XPC_FLAGS': '0x0', 15:26:57 INFO - 'XPC_SERVICE_NAME': '0', 15:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 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 15:26:57 INFO - Cleaning up... 15:26:57 INFO - Return code: 0 15:26:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:57 INFO - 'HOME': '/Users/cltbld', 15:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PAGER': '/bin/cat', 15:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:26:57 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - 'XPC_FLAGS': '0x0', 15:26:57 INFO - 'XPC_SERVICE_NAME': '0', 15:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 INFO - Downloading/unpacking psutil>=3.1.1 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:01 INFO - Installing collected packages: psutil 15:27:01 INFO - Running setup.py install for psutil 15:27:01 INFO - building 'psutil._psutil_osx' extension 15:27: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:27: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 15:27: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 15:27: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 15:27:02 INFO - building 'psutil._psutil_posix' extension 15:27:02 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 15:27:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:27:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:27:02 INFO - ^ 15:27:02 INFO - 1 warning generated. 15:27:02 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 15:27:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:02 INFO - Successfully installed psutil 15:27:02 INFO - Cleaning up... 15:27:02 INFO - Return code: 0 15:27:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:02 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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27:02 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 15:27:02 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 15:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:02 INFO - 'HOME': '/Users/cltbld', 15:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:02 INFO - 'LOGNAME': 'cltbld', 15:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:02 INFO - 'MOZ_NO_REMOTE': '1', 15:27:02 INFO - 'NO_EM_RESTART': '1', 15:27:02 INFO - 'PAGER': '/bin/cat', 15:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:02 INFO - 'PWD': '/builds/slave/test', 15:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:02 INFO - 'SHELL': '/bin/bash', 15:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:02 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:02 INFO - 'USER': 'cltbld', 15:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:02 INFO - 'XPC_FLAGS': '0x0', 15:27:02 INFO - 'XPC_SERVICE_NAME': '0', 15:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:27:05 INFO - Installing collected packages: mozsystemmonitor 15:27:05 INFO - Running setup.py install for mozsystemmonitor 15:27:05 INFO - Successfully installed mozsystemmonitor 15:27:05 INFO - Cleaning up... 15:27:05 INFO - Return code: 0 15:27:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:05 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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27:05 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 15:27:05 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 15:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:05 INFO - 'HOME': '/Users/cltbld', 15:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:05 INFO - 'LOGNAME': 'cltbld', 15:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:05 INFO - 'MOZ_NO_REMOTE': '1', 15:27:05 INFO - 'NO_EM_RESTART': '1', 15:27:05 INFO - 'PAGER': '/bin/cat', 15:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:05 INFO - 'PWD': '/builds/slave/test', 15:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:05 INFO - 'SHELL': '/bin/bash', 15:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:05 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:05 INFO - 'USER': 'cltbld', 15:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:05 INFO - 'XPC_FLAGS': '0x0', 15:27:05 INFO - 'XPC_SERVICE_NAME': '0', 15:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:05 INFO - Downloading/unpacking jsonschema==2.5.1 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:27:08 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 15:27:08 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 15:27:08 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 15:27:08 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 15:27:08 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 15:27:08 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 15:27:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:09 INFO - warning: no files found matching '*.txt' 15:27:09 INFO - no previously-included directories found matching 'build' 15:27:09 INFO - no previously-included directories found matching 'dist' 15:27:09 INFO - no previously-included directories found matching '.git*' 15:27:09 INFO - Installing collected packages: jsonschema, functools32 15:27:09 INFO - Running setup.py install for functools32 15:27:09 INFO - warning: no files found matching '*.txt' 15:27:09 INFO - no previously-included directories found matching 'build' 15:27:09 INFO - no previously-included directories found matching 'dist' 15:27:09 INFO - no previously-included directories found matching '.git*' 15:27:09 INFO - Successfully installed jsonschema functools32 15:27:09 INFO - Cleaning up... 15:27:09 INFO - Return code: 0 15:27:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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', '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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:27: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 functools32==3.2.3-2 15:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:09 INFO - 'HOME': '/Users/cltbld', 15:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:09 INFO - 'LOGNAME': 'cltbld', 15:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:09 INFO - 'MOZ_NO_REMOTE': '1', 15:27:09 INFO - 'NO_EM_RESTART': '1', 15:27:09 INFO - 'PAGER': '/bin/cat', 15:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:09 INFO - 'PWD': '/builds/slave/test', 15:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:09 INFO - 'SHELL': '/bin/bash', 15:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:09 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:09 INFO - 'USER': 'cltbld', 15:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:09 INFO - 'XPC_FLAGS': '0x0', 15:27:09 INFO - 'XPC_SERVICE_NAME': '0', 15:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:27:09 INFO - Cleaning up... 15:27:09 INFO - Return code: 0 15:27:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27: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 15:27: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 15:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:09 INFO - 'HOME': '/Users/cltbld', 15:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:09 INFO - 'LOGNAME': 'cltbld', 15:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:09 INFO - 'MOZ_NO_REMOTE': '1', 15:27:09 INFO - 'NO_EM_RESTART': '1', 15:27:09 INFO - 'PAGER': '/bin/cat', 15:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:09 INFO - 'PWD': '/builds/slave/test', 15:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:09 INFO - 'SHELL': '/bin/bash', 15:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:09 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:09 INFO - 'USER': 'cltbld', 15:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:09 INFO - 'XPC_FLAGS': '0x0', 15:27:09 INFO - 'XPC_SERVICE_NAME': '0', 15:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:12 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27:13 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 15:27:13 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 15:27:13 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 15:27:13 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 15:27:13 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 15:27:13 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 15:27:13 INFO - Downloading docopt-0.6.1.tar.gz 15:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:14 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:14 INFO - Running setup.py install for blobuploader 15:27:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:14 INFO - Running setup.py install for requests 15:27:14 INFO - Running setup.py install for docopt 15:27:14 INFO - Successfully installed blobuploader requests docopt 15:27:14 INFO - Cleaning up... 15:27:14 INFO - Return code: 0 15:27:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27: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 15:27: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 15:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:14 INFO - 'HOME': '/Users/cltbld', 15:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:14 INFO - 'LOGNAME': 'cltbld', 15:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:14 INFO - 'MOZ_NO_REMOTE': '1', 15:27:14 INFO - 'NO_EM_RESTART': '1', 15:27:14 INFO - 'PAGER': '/bin/cat', 15:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:14 INFO - 'PWD': '/builds/slave/test', 15:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:14 INFO - 'SHELL': '/bin/bash', 15:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:14 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:14 INFO - 'USER': 'cltbld', 15:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:14 INFO - 'XPC_FLAGS': '0x0', 15:27:14 INFO - 'XPC_SERVICE_NAME': '0', 15:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-8Ma264-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-emkMzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-UOaf8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-w7ZiMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-hJX6dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tD9qXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-xBv012-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:15 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-xRX0hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-G_Jo8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-aNTTF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-cMrliA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-IOhlS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-e3uY6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4lHyjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-2P1YIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ZSyOwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:16 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-vxkyGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:16 INFO - Running setup.py install for manifestparser 15:27:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:17 INFO - Running setup.py install for mozcrash 15:27:17 INFO - Running setup.py install for mozdebug 15:27:17 INFO - Running setup.py install for mozdevice 15:27:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:17 INFO - Running setup.py install for mozfile 15:27:17 INFO - Running setup.py install for mozhttpd 15:27:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:17 INFO - Running setup.py install for mozinfo 15:27:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Running setup.py install for mozInstall 15:27:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Running setup.py install for mozleak 15:27:18 INFO - Running setup.py install for mozlog 15:27:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Running setup.py install for moznetwork 15:27:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Running setup.py install for mozprocess 15:27:18 INFO - Running setup.py install for mozprofile 15:27:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:18 INFO - Running setup.py install for mozrunner 15:27:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:19 INFO - Running setup.py install for mozscreenshot 15:27:19 INFO - Running setup.py install for moztest 15:27:19 INFO - Running setup.py install for mozversion 15:27:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:19 INFO - Cleaning up... 15:27:19 INFO - Return code: 0 15:27:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27: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 15:27: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 15:27:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:19 INFO - 'HOME': '/Users/cltbld', 15:27:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:19 INFO - 'LOGNAME': 'cltbld', 15:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:19 INFO - 'MOZ_NO_REMOTE': '1', 15:27:19 INFO - 'NO_EM_RESTART': '1', 15:27:19 INFO - 'PAGER': '/bin/cat', 15:27:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:19 INFO - 'PWD': '/builds/slave/test', 15:27:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:19 INFO - 'SHELL': '/bin/bash', 15:27:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:19 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:19 INFO - 'USER': 'cltbld', 15:27:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:19 INFO - 'XPC_FLAGS': '0x0', 15:27:19 INFO - 'XPC_SERVICE_NAME': '0', 15:27:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:19 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Iiks9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27: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)) 15:27:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:19 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-bSXBCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:20 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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-7T9Xx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-31LvqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-rYzEi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-DDYD86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Ek8jXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-vE2J12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-P_m9lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Beu2s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27: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)) 15:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:20 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-AqQWD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:21 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)) 15:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:21 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-bjXiNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:21 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)) 15:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:21 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-UutnHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27: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)) 15:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:21 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-zevzL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27: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)) 15:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:21 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Gk97eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27: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)) 15:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:21 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SPftgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27: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)) 15:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:21 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wmCxsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:24 INFO - Downloading blessings-1.6.tar.gz 15:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:24 INFO - Installing collected packages: blessings 15:27:24 INFO - Running setup.py install for blessings 15:27:24 INFO - Successfully installed blessings 15:27:24 INFO - Cleaning up... 15:27:24 INFO - Return code: 0 15:27:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:24 INFO - Reading from file tmpfile_stdout 15:27:24 INFO - Current package versions: 15:27:24 INFO - blessings == 1.6 15:27:24 INFO - blobuploader == 1.2.4 15:27:24 INFO - docopt == 0.6.1 15:27:24 INFO - functools32 == 3.2.3-2 15:27:24 INFO - jsonschema == 2.5.1 15:27:24 INFO - manifestparser == 1.1 15:27:24 INFO - mozInstall == 1.12 15:27:24 INFO - mozcrash == 1.0 15:27:24 INFO - mozdebug == 0.1 15:27:24 INFO - mozdevice == 0.49 15:27:24 INFO - mozfile == 1.2 15:27:24 INFO - mozhttpd == 0.7 15:27:24 INFO - mozinfo == 0.9 15:27:24 INFO - mozleak == 0.1 15:27:24 INFO - mozlog == 3.4 15:27:24 INFO - moznetwork == 0.27 15:27:24 INFO - mozprocess == 0.24 15:27:24 INFO - mozprofile == 0.28 15:27:24 INFO - mozrunner == 6.13 15:27:24 INFO - mozscreenshot == 0.1 15:27:24 INFO - mozsystemmonitor == 0.3 15:27:24 INFO - moztest == 0.8 15:27:24 INFO - mozversion == 1.4 15:27:24 INFO - psutil == 3.1.1 15:27:24 INFO - requests == 1.2.3 15:27:24 INFO - wsgiref == 0.1.2 15:27:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:24 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')]} 15:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27: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 15:27: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 15:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:25 INFO - 'HOME': '/Users/cltbld', 15:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:25 INFO - 'LOGNAME': 'cltbld', 15:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:25 INFO - 'MOZ_NO_REMOTE': '1', 15:27:25 INFO - 'NO_EM_RESTART': '1', 15:27:25 INFO - 'PAGER': '/bin/cat', 15:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:25 INFO - 'PWD': '/builds/slave/test', 15:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:25 INFO - 'SHELL': '/bin/bash', 15:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:25 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:25 INFO - 'USER': 'cltbld', 15:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:25 INFO - 'XPC_FLAGS': '0x0', 15:27:25 INFO - 'XPC_SERVICE_NAME': '0', 15:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27:25 INFO - Cleaning up... 15:27:25 INFO - Return code: 0 15:27:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:26 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 0x1085a4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085a7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f825c2b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, '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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 15:27:26 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 15:27:26 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 15:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:26 INFO - 'HOME': '/Users/cltbld', 15:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:26 INFO - 'LOGNAME': 'cltbld', 15:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:26 INFO - 'MOZ_NO_REMOTE': '1', 15:27:26 INFO - 'NO_EM_RESTART': '1', 15:27:26 INFO - 'PAGER': '/bin/cat', 15:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:26 INFO - 'PWD': '/builds/slave/test', 15:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:26 INFO - 'SHELL': '/bin/bash', 15:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:26 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:26 INFO - 'USER': 'cltbld', 15:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:26 INFO - 'XPC_FLAGS': '0x0', 15:27:26 INFO - 'XPC_SERVICE_NAME': '0', 15:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:26 INFO - Cleaning up... 15:27:26 INFO - Return code: 0 15:27:26 INFO - Running post-action listener: _resource_record_post_action 15:27:26 INFO - Running post-action listener: _start_resource_monitoring 15:27:26 INFO - Starting resource monitoring. 15:27:26 INFO - [mozharness: 2017-04-07 22:27:26.629179Z] Finished create-virtualenv step (success) 15:27:26 INFO - [mozharness: 2017-04-07 22:27:26.630180Z] Running install step. 15:27:26 INFO - Running pre-action listener: _resource_record_pre_action 15:27:26 INFO - Running main action method: install 15:27:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:26 INFO - Reading from file tmpfile_stdout 15:27:26 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:26 INFO - Reading from file tmpfile_stdout 15:27:26 INFO - Output received: 15:27:26 INFO - Usage: mozinstall [options] installer 15:27:26 INFO - Options: 15:27:26 INFO - -h, --help show this help message and exit 15:27:26 INFO - -d DEST, --destination=DEST 15:27:26 INFO - Directory to install application into. [default: 15:27:26 INFO - "/builds/slave/test"] 15:27:26 INFO - --app=APP Application being installed. [default: firefox] 15:27:26 INFO - mkdir: /builds/slave/test/build/application 15:27:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:27:41 INFO - Reading from file tmpfile_stdout 15:27:41 INFO - Output received: 15:27:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:27:41 INFO - Running post-action listener: _resource_record_post_action 15:27:41 INFO - [mozharness: 2017-04-07 22:27:41.787408Z] Finished install step (success) 15:27:41 INFO - [mozharness: 2017-04-07 22:27:41.787543Z] Running run-tests step. 15:27:41 INFO - Running pre-action listener: _resource_record_pre_action 15:27:41 INFO - Running main action method: run_tests 15:27:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:41 INFO - 2017-04-07 15:27:41.801 screenresolution[1635:7358] starting screenresolution argv=screenresolution get 15:27:41 INFO - 2017-04-07 15:27:41.804 screenresolution[1635:7358] Display 0: 1600x1200x32@60 15:27:41 INFO - 2017-04-07 15:27:41.810 screenresolution[1636:7360] starting screenresolution argv=screenresolution list 15:27:41 INFO - Available Modes on Display 0 15:27:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:42 INFO - Intel Iris: 15:27:42 INFO - Chipset Model: Intel Iris 15:27:42 INFO - Type: GPU 15:27:42 INFO - Bus: Built-In 15:27:42 INFO - VRAM (Dynamic, Max): 1536 MB 15:27:42 INFO - Vendor: Intel (0x8086) 15:27:42 INFO - Device ID: 0x0a2e 15:27:42 INFO - Revision ID: 0x0009 15:27:42 INFO - Displays: 15:27:42 INFO - Display: 15:27:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:42 INFO - Display Serial Number: 1600x1200 60 15:27:42 INFO - Main Display: Yes 15:27:42 INFO - Mirror: Off 15:27:42 INFO - Online: Yes 15:27:42 INFO - Rotation: Supported 15:27:42 INFO - Return code: 0 15:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:42 INFO - Python 2.7.3 15:27:42 INFO - Return code: 0 15:27:42 INFO - grabbing minidump binary from tooltool 15:27:42 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')]} 15:27:42 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 0x108382d30>, '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 0x1082a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108377be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:42 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 15:27:42 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 15:27:42 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 15:27:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:42 INFO - Return code: 0 15:27:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:27:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:27:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 15:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --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 15:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lNxKuDeWbz/Render', 15:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:42 INFO - 'HOME': '/Users/cltbld', 15:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:42 INFO - 'LOGNAME': 'cltbld', 15:27:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:42 INFO - 'MOZ_NO_REMOTE': '1', 15:27:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:42 INFO - 'NO_EM_RESTART': '1', 15:27:42 INFO - 'PAGER': '/bin/cat', 15:27:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:42 INFO - 'PWD': '/builds/slave/test', 15:27:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:42 INFO - 'SHELL': '/bin/bash', 15:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9Chz6SMmO/Listeners', 15:27:42 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 15:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:42 INFO - 'USER': 'cltbld', 15:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:42 INFO - 'XPC_FLAGS': '0x0', 15:27:42 INFO - 'XPC_SERVICE_NAME': '0', 15:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 15:27:42 INFO - mozversion application_buildid: 20170407135522 15:27:42 INFO - mozversion application_changeset: b4c7f4163f3e9d8a3652d80615037434c04682c1 15:27:42 INFO - mozversion application_display_name: Firefox 15:27:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:42 INFO - mozversion application_name: Firefox 15:27:42 INFO - mozversion application_remotingname: firefox 15:27:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:27:42 INFO - mozversion application_vendor: Mozilla 15:27:42 INFO - mozversion application_version: 53.0 15:27:42 INFO - mozversion platform_buildid: 20170407135522 15:27:42 INFO - mozversion platform_changeset: b4c7f4163f3e9d8a3652d80615037434c04682c1 15:27:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:27:42 INFO - mozversion platform_version: 53.0 15:27:42 INFO - using testdate: 1491604062 15:27:42 INFO - actual date: 1491604062 15:27:42 INFO - starting webserver on 'localhost:49236' 15:27:42 INFO - SUITE-START | Running 2 tests 15:27:42 INFO - TEST-START | dromaeo_css 15:27:42 INFO - operating with platform_type : mac_ 15:27:42 INFO - Initialising browser for dromaeo_css test... 15:27:42 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpZwAEbn/profile http://localhost:49236/getInfo.html) 15:27:44 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 15:27:44 INFO - PROCESS | 1646 | colorDepth:24 15:27:44 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 15:27:44 INFO - PROCESS | 1646 | __metrics 15:27:44 INFO - PROCESS | 1646 | 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" 15:27:44 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:27:45 INFO - TEST-INFO | 1646: exit 0 15:27:45 INFO - Browser initialized. 15:27:45 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:45 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpZwAEbn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:57 INFO - PROCESS | 1649 | RSS: Main: 167919616 15:27:57 INFO - PROCESS | 1649 | 15:31:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 15:31:02 INFO - PROCESS | 1649 | RSS: Main: 312930304 15:31:02 INFO - PROCESS | 1649 | 15:34:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 15:34:06 INFO - PROCESS | 1649 | RSS: Main: 307871744 15:34:06 INFO - PROCESS | 1649 | 15:37:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 15:37:09 INFO - PROCESS | 1649 | RSS: Main: 278962176 15:37:09 INFO - PROCESS | 1649 | 15:40:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 15:40:12 INFO - PROCESS | 1649 | RSS: Main: 269017088 15:40:12 INFO - PROCESS | 1649 | 15:43:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 15:43:15 INFO - PROCESS | 1649 | RSS: Main: 268578816 15:43:15 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 15:46:19 INFO - PROCESS | 1649 | RSS: Main: 321331200 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | __start_tp_report 15:46:19 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 15:46:19 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 15:46:19 INFO - PROCESS | 1649 | |i|pagename|runs| 15:46:19 INFO - PROCESS | 1649 | |0;dojo.html;3451.154467155547;3457.6023757267913;3458.446648536233;3476.5480487536615;3517.859285628575;5726.198332233485;5740.483356497914;5751.453611906867;5767.625104368213;5775.855603609906;5730.713464326788;5804.854878628036;5815.127730840376;5821.970890145543;5832;5016.598672106241;5188.740562971846;5234.947650523503;5265.183896496049;5298.523132918037;5134.204198349262;5158.226266060102;5169.121249387595;5318.282031925679;5325.866853328678;5203.86990325243;5234.790608375661;5244.187150991603;5264.131418315973;5321.547668448186;5292.073887069748;5302.151655735083;5306.965141797332;5312.442193569658;5313.946860531422;5125.38495380553;5172;5250.684958902478;5277;5316.734163291859;5630.493255606974;5636.774529018834;5647.209390685307;5721.971390143022;5741.827745167651;6196.566240363177;6267.185265915402;6271.560990730651;6280.874382512324;6283.497320214372;6242.344553821828;6283.8114856554375;6289.528285378569;6308.810735677937;6310.5898116622275;5730.169125476783;5774.307083150007;5780.306363236438;5842.386549412336;5850.151727999416;6259;6295.685215739195;6323.683815809191;6372.330905254974;6400.103985442041;6245.906311405332;6255.74977000924;6264.404881536247;6269.435750782452;6276.529260305495;5184.300119483897;6235.844103897439;6263.404976527223;6291.930371836799;6317.399847014526;6132.5084813409785;6169.043798211284;6186.907196392058;6198.194234749454;6218.036204388327;6270.529710271748;6284.654344011124;6294.181756371642;6296.275928268308;6300.117983482316;5011;5011.874703132378;5013.1227035268685;5032.924506132411;5046.4953504649975;4466;4480.439945006874;4482;4497.302918047708;4561.612262957619;5832.88334233313;5911.645301281937;5929.555283353766;5937.881242375129;6042.4561789438285;6281.96859015702;6297.055441683784;6304.684765761694;6311.147995020705;6320.020396838498;5953.255843019622;5953.583249172516;5978;5986.194918172653;6002.249718785152;5422.674639521562;5430.8913821723345;5441.5374693151525;5542.2795036644975;5554.583406244547;6282.654454004982;6295.433410993032;6325.9051114233325;6382.808515744535;6411.230652321565;6255.593386429868;6293.559450838397;6293.685315734287;6295;6299.118123462627;6207.472364849038;6383.968080159755;6389.97760358359;6403.871922561616;6435.195600549931;6058.303295120942;6186.4741496973265;6187.288461826947;6214.937850621617;6273.905891411541;6285.088662143872;6292.716827742671;6299.4645455135;6303.275123360872;6305.180326557518;4844.8304309349005;6207.286162091417;6221.222347206599;6232.283287421823;6247.5001999840815;6052.697365131814;6108.342071131602;6114.144019837316;6124.479419249235;6144.723487442986;6086.239220097488;6109.266887973294;6111.724972376165;6133.447989680772;6142.385761423822;6199.450137465634;6221.346758590283;6227.875442491216;6235.719392627252;6238.126662267196;5926.7925622603;5942.078977758454;6002.099685047103;6018.157457955977;6054.606450580698 15:46:19 INFO - PROCESS | 1649 | |1;ext.html;482.23084180731723;489.7624652043758;511.6137316326173;529.8436961096476;535.4324416118911;32274;36056.639433605655;42529.362059569095;44203.77898110513;45840.54159458404;45392.86517837056;45906.540934590645;45913.85215369609;46033.7698311508;46089.769551152196;9083.636654533811;9438.76403089923;9663.95168024159;9678.9837067108;9685.322027458045;9072.183503484684;11899.64301070965;12038.759224815498;12078;12293.754124917496;12028.037756979464;12099.153059285854;12103.939480302586;12105.213161144497;12105.455254513525;11928.880711192864;12002;12002.339871307075;12002.939985300018;12015.978641815456;11793.941030294794;11888.167828252026;11896;11908.761824763456;11914;41865;42038.78980605108;42074.57925420737;42143;42167.78916105431;4086.7752273624938;4136.296829538986;4149.771762553059;4165.854195103157;4179.832806687728;30935.38129237425;31613.051608451784;32622.347553048807;32917.50623740646;33235.011798584324;3253.886113985999;3419.26485805553;3422.845971931269;3430.519727238189;3455.1189446690933;514875.42562287324;515229;516535.9999999962;516626;522290;65177;65509;65540.68918621601;65598;65603;68141.3185868135;68269.65865170643;68372;68489.31510684929;68519.31480685229;17689.911550442164;17901.19444624995;17949.371771987917;17968.550786230448;17989.460316190536;12499.812502812465;12819;13494;13616.046876718534;13631;18642.889785969866;23230.883845581004;23301.7669823303;23311.88344058269;23348.533029339316;8900.42147260426;9046.185843274005;9061.59222834974;9062.320325975577;9140.115450933326;883.2492381475694;891.7101941868918;901.8241442918568;936.2930987104828;946.9952650236843;31687.841560792047;31952.840235799136;32121.196970075936;32310.83844580762;33116.503252451235;945.6831961292906;1095.780843831237;1109.5062697099713;1118.2284223885492;1206.7164216409137;15898.364065437485;16178.433754818525;16305.59236019109;16345.42791002333;16715.414960476326;670733;677561;678901;679006;680534;59702.80594388088;59706.70146649239;59750.70124649349;59847.40152598506;59849.803003939676;1391.979120313196;1436.2746812859439;1515.9621009474852;1548.5896237497072;1563.5543869996995;31332.686673132976;32967.83516082404;33095.50356744699;33297.167570810925;33777.662223377454;54728;55158;55256.72371638116;55394;55470.72264638651;577193;581697;582214;582508;583467.5786347458;36458.63541364553;37904.951480467775;38344.849654510406;39064.023399415244;45757.54242457533;40000;49069.75465122652;49409.50590494049;50276.245856311456;51307;34266.45697596026;34348.14129646779;34514.96455106351;35052.64947350596;35615.75344862918;34195;34432;35125.94622161339;35383.46924796182;35463.645363546035;39898.40152397774;40908.1818363637;41028.589714102476;41060.384094239205;41108.79445602753;27072.781724822038;33242.33515329631;33288.33423331568;33561.16097097495;35290.470642939865;26274.21177364682;26473.602895956963;26517.867410663595;26540;27092 15:46:19 INFO - PROCESS | 1649 | |2;jquery.html;364.0334910811794;399.2354640862748;403.8889305441005;409.3123552431917;437.07994671217085;20802.99999999998;21790.01944912479;21953.40769759863;22140.33578992633;22184;21675.45811354717;22053.669194962087;22415.439614009658;23469;23582.93876775549;5896.646201227929;6186.7525298987985;6204.751809927598;6206.472449841769;6213.627182369072;5725.026745453262;5769.3076830780365;6083.422074902899;6131.110988906628;6143.986242270043;5930.703464826763;6075.362086980869;6080.452759251666;6084.026555751081;6085.939140608603;5936.287645482548;5996.730147143389;6066.908996365058;6074.726637301332;6089.634621922699;5148.382194136728;5308.071087559701;5325.281087053237;5328.573714102862;5334.946650533522;27732.8906843726;27742.583861241896;27743.670759508786;27750.02874899369;28002.01992930258;2802.7897907657007;2805.551111822099;2822.167639542167;2843.829370237772;2925.195571217911;15829.762553561706;15954.122523261216;16088.839111608851;16232.513024609281;16398.761980830695;1665.4420769042385;1864.655038817823;1940.7768106667772;1960.7941166177632;1963;114458;118495;119025;119877;119979;11401.657950261506;11648;11727.648170554898;11758.823617645741;11965.222260553037;14952.775708364383;14982.250887455584;14988.175650339335;14991.250437478082;15035.173065481285;7652.852072189105;8696.869546956801;9004.234640055538;9031.50326732023;9148.130927561871;9033.793003483801;9038.322125840588;9050.230730387859;9099.863502047343;9185.494797786187;7181.8922716159295;7302.2697730226555;7308.30571095745;7310.963445182846;7335.266473352622;1976.6837306030966;2002.2991952816399;2002.929897453582;2003.0986056274735;2004.2684420186526;1027.2860362048305;1055.9155267578576;1072.4691277817374;1078.5092782783815;1133.4332833583208;21667;23004.19485318006;23590;23899.7610023901;23915.880420597787;888.8311220868014;963.0738522954092;1094.7317907112808;1126.5775334249656;1127.1602656021316;8660.78348041304;10754.731131721614;11172.938570835757;11191.384473853854;11216.214864959375;652236;732570;794370;799024;810697;147563;149176;157893.2105339466;160036.19981900015;175152;457.1702360216197;461.8614415675284;475.27520531190214;478.3207844860307;479.7673128532659;11407.486663100015;11600.361980091177;11636.858048327074;11816.645500634995;12068.034557235576;48096.7595162022;54147.729261353445;62379;63153.05270421039;63526;91948.78179263693;92418.15163696554;92827.53586232026;94200.52899735457;94822;8587.613557390057;8688.218060374596;8800.559972001502;8995.55022248898;9136.406133601295;10869.456527173452;13539.796903046265;13596.184228946295;13685.726285474433;13996.580102596938;11619.186656934271;11645.068394528587;12063.698407539881;12074.39628018613;12125;10003.849557300713;10372.17022638172;10822.621208257673;10894.400807955322;11459.885401145882;11313.830292545783;11463.713407164887;11907.821382679094;11908.285502869856;12220.266783992989;8774.956125219333;8836.91163088361;9104.772380690536;9110.544472776468;9128.224100951227;10088.64689735885;11597.594084207012;11772.293662380285;11987.981021613261;12293.262404255773 15:46:19 INFO - PROCESS | 1649 | |3;mootools.html;1379.055347087246;1468.65617959567;1485.6434455730625;1493.3205391546853;1504.3456096597977;7674.50115742477;8032.317253033492;8305.252527272543;8556.74329770108;8563.400561960665;8483.448575842565;8523;8563.785905352353;8564.357673174505;8566.742997710064;2363.6809030780882;2398.9760102398927;2403.6034054381007;2404.3027522018683;2405.5669979403788;2156.8490205685607;2232.10715713715;2361.126383238204;2376.0970831084164;2440.8535487870786;2394.4971555973266;2399.892004859777;2400.2679182849224;2403.555342261687;2407.0973384980634;2357.752435994213;2375.798057165134;2381.1784934197676;2385.0221409222136;2386.331827088418;2357.7642235776457;2390.5577468168444;2393.2939782764124;2401.591729406005;2402.555527227451;8581.95709021451;8645.783855403603;8668.52323122228;8669.869951950663;8676.696315628986;5228.189630607262;5387.838364849061;5395.757190926418;5400.78396864125;5406.756695948692;3474.1314671332166;3640.308341415123;3685.0971511979737;3692.9446058309145;3699.9445008324897;1134.4214450630157;1156.8149096144577;1172.7654469106128;1271.396086858744;1297.9221246725226;10916.01755841978;10963.945180274048;11106.777864442665;11115.499802508906;11117.055050320732;4734.360861283752;4748.2543182653435;4769.618430525549;4842.757862106881;4862.95137048632;9764.951175244078;9775.364601301035;9783;9790.657326993522;9795.902040979641;4786.827227329327;5240.213967904845;5296.417394086648;5339.626226164131;5442.510174084351;4859.635527335464;4915.410150781858;4974.77613507393;4987.850364489072;5001.72490513018;3704.795941319082;3837.059920319484;3837.13664425502;3969.4045893115685;4040.454538637305;1287.0861688201483;1290.5031562848183;1295.6760809797552;1302.947882084725;1308.8363954505687;908.5593487158723;920.9777147366418;932.7481579973505;933.6685476655825;981.0238812381583;5594.748236329375;5656.43435656431;5847.44449277318;5989.8203053908455;6071.908921366095;1004.598160735697;1017.4810846468206;1017.699778565325;1025.7486915705551;1057.3074636113358;3235.223546348859;3285.5400243965864;3637.8544858205373;3878.864239751595;4038.757674539537;9746.269029822792;10046.14607758334;10179.949100254451;10322.22583306255;10327.173826093895;9775.364601300893;10099.69700908974;10290.382577045251;10309.381437113798;10311.793764124675;7900;8173.836523269501;8191.303739182117;8193.303569196565;8194.30348420379;5814.3604203538425;5862.648241105548;5885;6021.277446706424;6094.8171554853425;9360.11078947499;9482.762930926781;9505.42967421957;9508.28687848428;9523.714288571355;9248.537573121452;9570.712878613653;9585.185259253041;9596.808063838824;9659.951700241454;7795.181505941794;7988.320992715684;8055.959720201596;8058.556779377191;8062.8790568142695;7865.567393793167;7921.207879212033;7946.40401969843;7968.7609371718945;8010;6988.859421724809;7025.946108083828;7046.436285097077;7064.823379415556;7139.892901606376;6947.930520694728;6987.6855541499735;6992.706778552702;7042.507024508235;7171.641417928979;6451.032345148265;6506.186726659168;6591.5056370773345;6593.109930159367;6604.669766511752;5025.723585202849;5180.352455943007;5181.611379146504;5232.424433312256;5308.875528658989;5071.568916642127;5169.741512924414;5179.274901513866;5248.396434410091;5384.946150538444 15:46:19 INFO - PROCESS | 1649 | |4;prototype.html;359.95680518337787;363.5728019576997;374.7021118211022;380.6840322532299;382.8181613733479;5154.74226288686;5348.304720386354;5409.702466364353;5430.8913821723545;5485.616006879515;4818.42178938527;5248.291480650111;5316.016536940669;5316.033067764933;5400.405955344909;3518.700910422617;3741.9625803741887;3865.942010869839;4229.978850105746;4288.69979101463;4103.651189648884;4220.810063547133;4230.217409779185;4273.871783846474;4314.697971142005;3522.4011917974008;3673.3938900081453;4098.077932465187;4267.1892340455215;4311;4199.181159673864;4226.450561426995;4232.597903199191;4244.19360321541;4245.15096980602;3150.928684247344;3341.2124513385465;3812.3137835189655;3836.290286297044;3855.8457661693496;4500.572445617661;4891.779869905863;5253.86865328366;5273.709945952971;5295.708736019517;3734.8982050295226;4768.926991426936;4947.332110165117;4950.9504904950845;4962.801487940478;5017.899642007176;5621.690807005613;5696.572757043238;5744.712764361807;5745.563609097726;3530.382183117944;3697.759645623026;3922.235164142993;4182.121754431573;4255.468066491689;5964.343922168558;5998.890759829531;6003.0695242237525;6023.45788879003;6028.336882942873;3822.8722526854644;4326.329418940069;4330.7401555906745;4332.1371810121955;4344.847930322424;3492.633273506296;4297.484301883732;4344.478662560513;4346.174226896879;4377.409049778239;4081.4286499697832;4843.15244832153;4900.485449027872;4926.408830940239;4927.482614325516;5517.723764082868;5549.6115271931385;5832;5836.416358364215;5850.460471414818;1282.410091357967;1320.214472388927;1325.6553296143072;1335.3256605414397;1423.0892228973464;919.6551293265026;990.811026767867;998.8912307338848;1004.50779118233;1005.6027868991707;4518.864434066917;4523.592876641118;4536.591706746409;5030.8239211627415;5063.30378823461;4967.820594819318;5246.16061430177;5518.144687573433;5540.556755459554;5554.583406244547;4060.878173654795;4061.6750659947133;5033.899322013539;5043.3443652325695;5065.569426598707;2466.703995520513;2526.9747302527107;2643.2598872315784;2716.5381885079582;2934.9874293368753;4778.402699662543;5307.734613269321;5639;5703.857403564944;5809.663777331153;5273.156294992783;5358.758855851496;5428.375736790241;5739.62692424991;5753.942460575425;5222.451642577551;5490.066688662937;5758.62568933018;5786.826395208066;5789.247397838254;5442.727863606725;5482.013237617267;5568.9443105568425;5569.79736651419;5590.496855283044;4792.447175183659;5274.89450210986;5298.44366341544;5500.5973476763165;5568.721563921707;5092.719900405513;5714.257146570919;5743.224664670216;5753.913691294718;5798.971005144947;3703.833327500323;3718.925621487609;3728.0120767997046;3728.366177749735;3763.623637636324;4652.534746525455;4915.852524424273;5509.173623956278;5534;5600.243967064394;5505.256790333414;5537.501624853782;5543.805966791143;5643.560891972521;5676.68778217202;4745.905081898273;4822.469528351809;5660.235868157746;5664.631798933056;5681.914686355771;5160;5254.894902102013;5498.890022199454;5560.610757246954;5596.424201563228;5676.262085928803;5681.431856814285;5682.062459694104;5701.800436984686;5707.7716891325545;4505.842295519641;4615.538446155358;5097.949020509747;5531.225628412106;5597.496225339739 15:46:19 INFO - PROCESS | 1649 | |5;yui.html;733.5874713597707;757.56440046973;792.8493586218618;859.6819176904544;877.4954401219296;15348.769768453469;16017.439389621366;16089;16098.758518622215;16161.919190404062;12313;14961.251937403113;15004.774928376082;15021.849781502182;15033.248337583105;699.7375984005997;723.0094770164882;884.5577211394303;894.0657013420958;898.5417437107058;732.6263605561148;851.9829603407928;885.0706757904208;886.5168483176652;888.0675290944515;950.8573713942894;960.5677445149676;963.3208587945481;966.3284017607765;967.5791030901545;962.629387685746;962.7593101724569;962.9133377995944;966.8259713251612;967.5887747707231;602.7860109661051;714.3891972363606;717.1394326807851;717.408138285911;717.7236763845905;15313.770293445607;15797;15823.525294241192;16076.839231607768;16226.269817858225;14579.781303280459;14731.189784561844;14780.926095369454;14858.628534286729;14894.925525372411;11557.422128893522;11743.882561174365;11760.882391176065;11784.528618855236;12326.383680815923;3969.9007524811823;4048.878533643966;4089.8773036808943;4098.057446787256;4098.180363927227;105889;106302;106879.99999999923;107519.46240268827;111158;9802.411855288705;11332.64008319007;11459.197856150156;11528.135389845795;11587.594434194763;23632;23643.408914776923;23654.7634523656;24066.39834004164;24077.51844963126;7748.806279843049;8014.118446970829;8043.235892590312;8074.3540516759695;8091.514509129471;4394.780260986938;4394.8242070317465;4422.513523512411;4512.255477846119;4581.770911454414;3711.0907827582414;3782.678472329828;3805.06775839921;3818.866339678098;3832.3101841668768;680.4930326906486;681.8363592737807;686.8694947959872;700.0339531446571;712.576017269734;666.6966530228734;677.2347247610169;701.8982247574073;701.9719211231494;732.3701616609711;10185.592576296865;10236.821244550169;10289.691309260734;10462.68611941643;10464.52909619069;684.1516519515864;698.4168219536642;702.8980797784293;724.1708244060521;725.3399406540024;4973.90052198954;5065.290859279704;5071.54356107952;5078.949210507922;5088.516590923857;72317;87337.12662873417;94222.58666120014;101896;105534.4723276394;69177;84227.73658395007;84408.57795711105;86143;86915;59599.80800383968;63483;65914;74901.25098748943;75760.86358704514;9644.911252561327;9656.115457216169;9703.417794932328;9765.511724413609;9769.80460390774;48217.75891120522;49365.25952110649;50540;50606.2409063857;51159.48840511547;57949.420505794405;59611;61759.38240617716;65504.01743973939;66745.66627166833;13630.591082267549;13747.931260343634;13785.140160755005;14043.859561404255;14059.156450612996;14191.219482928538;14910.701785964437;15435.61410964735;15815;15873.52379428619;13340.799888001493;14090.718185636435;14365.7845132321;14405.06367086136;14804.037737547456;13716.725665486834;14141.929290353482;14206.857931420553;14250.643733906736;14695.632609184855;13148.408321625358;13961.860381396056;14124.223167725462;14221.573352799433;14588.197649129399;9789.216862651114;10564.366138031743;10623.415712135908;10955.178361622751;10968;10890.509927053143;11136.10911127124;11422.657320280405;11646.941765291458;11876.168668193144 15:46:19 INFO - PROCESS | 1649 | __end_tp_report 15:46:19 INFO - PROCESS | 1649 | __start_cc_report 15:46:19 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1523 15:46:19 INFO - PROCESS | 1649 | __end_cc_report 15:46:19 INFO - PROCESS | 1649 | __startTimestamp1491605179507__endTimestamp 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | ------- Summary: start ------- 15:46:19 INFO - PROCESS | 1649 | Number of tests: 6 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5801.32 Median:6054.61 stddev:637.61 (10.5%) stddev-sans-first:612.33 15:46:19 INFO - PROCESS | 1649 | Values: 3451.2 3457.6 3458.4 3476.5 3517.9 5726.2 5740.5 5751.5 5767.6 5775.9 5730.7 5804.9 5815.1 5822.0 5832.0 5016.6 5188.7 5234.9 5265.2 5298.5 5134.2 5158.2 5169.1 5318.3 5325.9 5203.9 5234.8 5244.2 5264.1 5321.5 5292.1 5302.2 5307.0 5312.4 5313.9 5125.4 5172.0 5250.7 5277.0 5316.7 5630.5 5636.8 5647.2 5722.0 5741.8 6196.6 6267.2 6271.6 6280.9 6283.5 6242.3 6283.8 6289.5 6308.8 6310.6 5730.2 5774.3 5780.3 5842.4 5850.2 6259.0 6295.7 6323.7 6372.3 6400.1 6245.9 6255.7 6264.4 6269.4 6276.5 5184.3 6235.8 6263.4 6291.9 6317.4 6132.5 6169.0 6186.9 6198.2 6218.0 6270.5 6284.7 6294.2 6296.3 6300.1 5011.0 5011.9 5013.1 5032.9 5046.5 4466.0 4480.4 4482.0 4497.3 4561.6 5832.9 5911.6 5929.6 5937.9 6042.5 6282.0 6297.1 6304.7 6311.1 6320.0 5953.3 5953.6 5978.0 5986.2 6002.2 5422.7 5430.9 5441.5 5542.3 5554.6 6282.7 6295.4 6325.9 6382.8 6411.2 6255.6 6293.6 6293.7 6295.0 6299.1 6207.5 6384.0 6390.0 6403.9 6435.2 6058.3 6186.5 6187.3 6214.9 6273.9 6285.1 6292.7 6299.5 6303.3 6305.2 4844.8 6207.3 6221.2 6232.3 6247.5 6052.7 6108.3 6114.1 6124.5 6144.7 6086.2 6109.3 6111.7 6133.4 6142.4 6199.5 6221.3 6227.9 6235.7 6238.1 5926.8 5942.1 6002.1 6018.2 6054.6 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:73737.97 Median:37181.79 stddev:158957.70 (427.5%) stddev-sans-first:159308.46 15:46:19 INFO - PROCESS | 1649 | Values: 482.2 489.8 511.6 529.8 535.4 32274.0 36056.6 42529.4 44203.8 45840.5 45392.9 45906.5 45913.9 46033.8 46089.8 9083.6 9438.8 9664.0 9679.0 9685.3 9072.2 11899.6 12038.8 12078.0 12293.8 12028.0 12099.2 12103.9 12105.2 12105.5 11928.9 12002.0 12002.3 12002.9 12016.0 11793.9 11888.2 11896.0 11908.8 11914.0 41865.0 42038.8 42074.6 42143.0 42167.8 4086.8 4136.3 4149.8 4165.9 4179.8 30935.4 31613.1 32622.3 32917.5 33235.0 3253.9 3419.3 3422.8 3430.5 3455.1 514875.4 515229.0 516536.0 516626.0 522290.0 65177.0 65509.0 65540.7 65598.0 65603.0 68141.3 68269.7 68372.0 68489.3 68519.3 17689.9 17901.2 17949.4 17968.6 17989.5 12499.8 12819.0 13494.0 13616.0 13631.0 18642.9 23230.9 23301.8 23311.9 23348.5 8900.4 9046.2 9061.6 9062.3 9140.1 883.2 891.7 901.8 936.3 947.0 31687.8 31952.8 32121.2 32310.8 33116.5 945.7 1095.8 1109.5 1118.2 1206.7 15898.4 16178.4 16305.6 16345.4 16715.4 670733.0 677561.0 678901.0 679006.0 680534.0 59702.8 59706.7 59750.7 59847.4 59849.8 1392.0 1436.3 1516.0 1548.6 1563.6 31332.7 32967.8 33095.5 33297.2 33777.7 54728.0 55158.0 55256.7 55394.0 55470.7 577193.0 581697.0 582214.0 582508.0 583467.6 36458.6 37905.0 38344.8 39064.0 45757.5 40000.0 49069.8 49409.5 50276.2 51307.0 34266.5 34348.1 34515.0 35052.6 35615.8 34195.0 34432.0 35125.9 35383.5 35463.6 39898.4 40908.2 41028.6 41060.4 41108.8 27072.8 33242.3 33288.3 33561.2 35290.5 26274.2 26473.6 26517.9 26540.0 27092.0 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:41313.76 Median:23907.82 stddev:126395.72 (528.7%) stddev-sans-first:126712.89 15:46:19 INFO - PROCESS | 1649 | Values: 364.0 399.2 403.9 409.3 437.1 20803.0 21790.0 21953.4 22140.3 22184.0 21675.5 22053.7 22415.4 23469.0 23582.9 5896.6 6186.8 6204.8 6206.5 6213.6 5725.0 5769.3 6083.4 6131.1 6144.0 5930.7 6075.4 6080.5 6084.0 6085.9 5936.3 5996.7 6066.9 6074.7 6089.6 5148.4 5308.1 5325.3 5328.6 5334.9 27732.9 27742.6 27743.7 27750.0 28002.0 2802.8 2805.6 2822.2 2843.8 2925.2 15829.8 15954.1 16088.8 16232.5 16398.8 1665.4 1864.7 1940.8 1960.8 1963.0 114458.0 118495.0 119025.0 119877.0 119979.0 11401.7 11648.0 11727.6 11758.8 11965.2 14952.8 14982.3 14988.2 14991.3 15035.2 7652.9 8696.9 9004.2 9031.5 9148.1 9033.8 9038.3 9050.2 9099.9 9185.5 7181.9 7302.3 7308.3 7311.0 7335.3 1976.7 2002.3 2002.9 2003.1 2004.3 1027.3 1055.9 1072.5 1078.5 1133.4 21667.0 23004.2 23590.0 23899.8 23915.9 888.8 963.1 1094.7 1126.6 1127.2 8660.8 10754.7 11172.9 11191.4 11216.2 652236.0 732570.0 794370.0 799024.0 810697.0 147563.0 149176.0 157893.2 160036.2 175152.0 457.2 461.9 475.3 478.3 479.8 11407.5 11600.4 11636.9 11816.6 12068.0 48096.8 54147.7 62379.0 63153.1 63526.0 91948.8 92418.2 92827.5 94200.5 94822.0 8587.6 8688.2 8800.6 8995.6 9136.4 10869.5 13539.8 13596.2 13685.7 13996.6 11619.2 11645.1 12063.7 12074.4 12125.0 10003.8 10372.2 10822.6 10894.4 11459.9 11313.8 11463.7 11907.8 11908.3 12220.3 8775.0 8836.9 9104.8 9110.5 9128.2 10088.6 11597.6 11772.3 11988.0 12293.3 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5601.48 Median:5230.31 stddev:3031.57 (58.0%) stddev-sans-first:3023.46 15:46:19 INFO - PROCESS | 1649 | Values: 1379.1 1468.7 1485.6 1493.3 1504.3 7674.5 8032.3 8305.3 8556.7 8563.4 8483.4 8523.0 8563.8 8564.4 8566.7 2363.7 2399.0 2403.6 2404.3 2405.6 2156.8 2232.1 2361.1 2376.1 2440.9 2394.5 2399.9 2400.3 2403.6 2407.1 2357.8 2375.8 2381.2 2385.0 2386.3 2357.8 2390.6 2393.3 2401.6 2402.6 8582.0 8645.8 8668.5 8669.9 8676.7 5228.2 5387.8 5395.8 5400.8 5406.8 3474.1 3640.3 3685.1 3692.9 3699.9 1134.4 1156.8 1172.8 1271.4 1297.9 10916.0 10963.9 11106.8 11115.5 11117.1 4734.4 4748.3 4769.6 4842.8 4863.0 9765.0 9775.4 9783.0 9790.7 9795.9 4786.8 5240.2 5296.4 5339.6 5442.5 4859.6 4915.4 4974.8 4987.9 5001.7 3704.8 3837.1 3837.1 3969.4 4040.5 1287.1 1290.5 1295.7 1302.9 1308.8 908.6 921.0 932.7 933.7 981.0 5594.7 5656.4 5847.4 5989.8 6071.9 1004.6 1017.5 1017.7 1025.7 1057.3 3235.2 3285.5 3637.9 3878.9 4038.8 9746.3 10046.1 10179.9 10322.2 10327.2 9775.4 10099.7 10290.4 10309.4 10311.8 7900.0 8173.8 8191.3 8193.3 8194.3 5814.4 5862.6 5885.0 6021.3 6094.8 9360.1 9482.8 9505.4 9508.3 9523.7 9248.5 9570.7 9585.2 9596.8 9660.0 7795.2 7988.3 8056.0 8058.6 8062.9 7865.6 7921.2 7946.4 7968.8 8010.0 6988.9 7025.9 7046.4 7064.8 7139.9 6947.9 6987.7 6992.7 7042.5 7171.6 6451.0 6506.2 6591.5 6593.1 6604.7 5025.7 5180.4 5181.6 5232.4 5308.9 5071.6 5169.7 5179.3 5248.4 5384.9 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4548.81 Median:5032.36 stddev:1360.05 (27.0%) stddev-sans-first:1327.02 15:46:19 INFO - PROCESS | 1649 | Values: 360.0 363.6 374.7 380.7 382.8 5154.7 5348.3 5409.7 5430.9 5485.6 4818.4 5248.3 5316.0 5316.0 5400.4 3518.7 3742.0 3865.9 4230.0 4288.7 4103.7 4220.8 4230.2 4273.9 4314.7 3522.4 3673.4 4098.1 4267.2 4311.0 4199.2 4226.5 4232.6 4244.2 4245.2 3150.9 3341.2 3812.3 3836.3 3855.8 4500.6 4891.8 5253.9 5273.7 5295.7 3734.9 4768.9 4947.3 4951.0 4962.8 5017.9 5621.7 5696.6 5744.7 5745.6 3530.4 3697.8 3922.2 4182.1 4255.5 5964.3 5998.9 6003.1 6023.5 6028.3 3822.9 4326.3 4330.7 4332.1 4344.8 3492.6 4297.5 4344.5 4346.2 4377.4 4081.4 4843.2 4900.5 4926.4 4927.5 5517.7 5549.6 5832.0 5836.4 5850.5 1282.4 1320.2 1325.7 1335.3 1423.1 919.7 990.8 998.9 1004.5 1005.6 4518.9 4523.6 4536.6 5030.8 5063.3 4967.8 5246.2 5518.1 5540.6 5554.6 4060.9 4061.7 5033.9 5043.3 5065.6 2466.7 2527.0 2643.3 2716.5 2935.0 4778.4 5307.7 5639.0 5703.9 5809.7 5273.2 5358.8 5428.4 5739.6 5753.9 5222.5 5490.1 5758.6 5786.8 5789.2 5442.7 5482.0 5568.9 5569.8 5590.5 4792.4 5274.9 5298.4 5500.6 5568.7 5092.7 5714.3 5743.2 5753.9 5799.0 3703.8 3718.9 3728.0 3728.4 3763.6 4652.5 4915.9 5509.2 5534.0 5600.2 5505.3 5537.5 5543.8 5643.6 5676.7 4745.9 4822.5 5660.2 5664.6 5681.9 5160.0 5254.9 5498.9 5560.6 5596.4 5676.3 5681.4 5682.1 5701.8 5707.8 4505.8 4615.5 5097.9 5531.2 5597.5 15:46:19 INFO - PROCESS | 1649 | 15:46:19 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:19891.64 Median:4394.80 stddev:27564.95 (627.2%) stddev-sans-first:27604.74 15:46:19 INFO - PROCESS | 1649 | Values: 733.6 757.6 792.8 859.7 877.5 15348.8 16017.4 16089.0 16098.8 16161.9 12313.0 14961.3 15004.8 15021.8 15033.2 699.7 723.0 884.6 894.1 898.5 732.6 852.0 885.1 886.5 888.1 950.9 960.6 963.3 966.3 967.6 962.6 962.8 962.9 966.8 967.6 602.8 714.4 717.1 717.4 717.7 15313.8 15797.0 15823.5 16076.8 16226.3 14579.8 14731.2 14780.9 14858.6 14894.9 11557.4 11743.9 11760.9 11784.5 12326.4 3969.9 4048.9 4089.9 4098.1 4098.2 105889.0 106302.0 106880.0 107519.5 111158.0 9802.4 11332.6 11459.2 11528.1 11587.6 23632.0 23643.4 23654.8 24066.4 24077.5 7748.8 8014.1 8043.2 8074.4 8091.5 4394.8 4394.8 4422.5 4512.3 4581.8 3711.1 3782.7 3805.1 3818.9 3832.3 680.5 681.8 686.9 700.0 712.6 666.7 677.2 701.9 702.0 732.4 10185.6 10236.8 10289.7 10462.7 10464.5 684.2 698.4 702.9 724.2 725.3 4973.9 5065.3 5071.5 5078.9 5088.5 72317.0 87337.1 94222.6 101896.0 105534.5 69177.0 84227.7 84408.6 86143.0 86915.0 59599.8 63483.0 65914.0 74901.3 75760.9 9644.9 9656.1 9703.4 9765.5 9769.8 48217.8 49365.3 50540.0 50606.2 51159.5 57949.4 59611.0 61759.4 65504.0 66745.7 13630.6 13747.9 13785.1 14043.9 14059.2 14191.2 14910.7 15435.6 15815.0 15873.5 13340.8 14090.7 14365.8 14405.1 14804.0 13716.7 14141.9 14206.9 14250.6 14695.6 13148.4 13961.9 14124.2 14221.6 14588.2 9789.2 10564.4 10623.4 10955.2 10968.0 10890.5 11136.1 11422.7 11646.9 11876.2 15:46:19 INFO - PROCESS | 1649 | -------- Summary: end -------- 15:46:19 INFO - PROCESS | 1649 | 15:46:20 INFO - TEST-INFO | 1649: exit 0 15:46:20 INFO - TEST-OK | dromaeo_css | took 1117676ms 15:46:20 INFO - TEST-START | kraken 15:46:20 INFO - operating with platform_type : mac_ 15:46:20 INFO - Initialising browser for kraken test... 15:46:20 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpR4W1cH/profile http://localhost:49236/getInfo.html) 15:46:22 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 15:46:22 INFO - PROCESS | 1659 | colorDepth:24 15:46:22 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 15:46:22 INFO - PROCESS | 1659 | __metrics 15:46:22 INFO - PROCESS | 1659 | 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" 15:46:22 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:22 INFO - TEST-INFO | 1659: exit 0 15:46:22 INFO - Browser initialized. 15:46:22 INFO - Running cycle 1/1 for kraken test... 15:46:22 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpR4W1cH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:34 INFO - PROCESS | 1661 | RSS: Main: 163618816 15:46:34 INFO - PROCESS | 1661 | 15:46:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:38 INFO - PROCESS | 1661 | RSS: Main: 214200320 15:46:38 INFO - PROCESS | 1661 | 15:46:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 15:46:41 INFO - PROCESS | 1661 | RSS: Main: 227315712 15:46:41 INFO - PROCESS | 1661 | 15:46:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 15:46:45 INFO - PROCESS | 1661 | RSS: Main: 323792896 15:46:45 INFO - PROCESS | 1661 | 15:46:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 15:46:47 INFO - PROCESS | 1661 | RSS: Main: 227311616 15:46:47 INFO - PROCESS | 1661 | 15:46:49 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:50 INFO - PROCESS | 1661 | RSS: Main: 230158336 15:46:50 INFO - PROCESS | 1661 | 15:46:53 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:53 INFO - PROCESS | 1661 | RSS: Main: 271884288 15:46:53 INFO - PROCESS | 1661 | 15:46:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:57 INFO - PROCESS | 1661 | RSS: Main: 270053376 15:46:57 INFO - PROCESS | 1661 | 15:46:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 15:47:00 INFO - PROCESS | 1661 | RSS: Main: 265506816 15:47:00 INFO - PROCESS | 1661 | 15:47:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:02 INFO - PROCESS | 1661 | RSS: Main: 244469760 15:47:02 INFO - PROCESS | 1661 | 15:47:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:05 INFO - PROCESS | 1661 | RSS: Main: 246853632 15:47:05 INFO - PROCESS | 1661 | 15:47:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:08 INFO - PROCESS | 1661 | RSS: Main: 252039168 15:47:08 INFO - PROCESS | 1661 | 15:47:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:11 INFO - PROCESS | 1661 | RSS: Main: 256565248 15:47:11 INFO - PROCESS | 1661 | 15:47:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:14 INFO - PROCESS | 1661 | RSS: Main: 258527232 15:47:14 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 15:47:16 INFO - PROCESS | 1661 | RSS: Main: 303116288 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | __start_tp_report 15:47:16 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 15:47:16 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 15:47:16 INFO - PROCESS | 1661 | |i|pagename|runs| 15:47:16 INFO - PROCESS | 1661 | |0;ai-astar;103;115;115;111;114;115;114;114;115;113 15:47:16 INFO - PROCESS | 1661 | |1;audio-beat-detection;141;108;106;141;109;105;108;108;127;105 15:47:16 INFO - PROCESS | 1661 | |2;audio-dft;185;186;184;182;179;183;183;183;181;186 15:47:16 INFO - PROCESS | 1661 | |3;audio-fft;82;59;58;87;59;59;59;58;73;58 15:47:16 INFO - PROCESS | 1661 | |4;audio-oscillator;81;69;85;70;69;68;81;67;70;81 15:47:16 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;88;87;90;86;89;85;90;85;88;86 15:47:16 INFO - PROCESS | 1661 | |6;imaging-darkroom;94;92;95;98;94;90;132;140;93;93 15:47:16 INFO - PROCESS | 1661 | |7;imaging-desaturate;87;86;85;87;88;85;85;84;85;93 15:47:16 INFO - PROCESS | 1661 | |8;json-parse-financial;55;52;52;54;55;56;57;55;55;52 15:47:16 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;66;81;71;72;70;67;67;67;70;67 15:47:16 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;86;82;80;83;81;82;86;88;88;101 15:47:16 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;142;134;131;129;124;154;127;126;152;146 15:47:16 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;165;164;165;164;160;163;161;164;164;145 15:47:16 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;64;64;63;63;64;67;68;78;82;81 15:47:16 INFO - PROCESS | 1661 | __end_tp_report 15:47:16 INFO - PROCESS | 1661 | __start_cc_report 15:47:16 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1921 15:47:16 INFO - PROCESS | 1661 | __end_cc_report 15:47:16 INFO - PROCESS | 1661 | __startTimestamp1491605236961__endTimestamp 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | ------- Summary: start ------- 15:47:16 INFO - PROCESS | 1661 | Number of tests: 14 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.50 stddev:3.70 (3.2%) stddev-sans-first:1.32 15:47:16 INFO - PROCESS | 1661 | Values: 103.0 115.0 115.0 111.0 114.0 115.0 114.0 114.0 115.0 113.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:108.50 stddev:14.73 (13.6%) stddev-sans-first:12.49 15:47:16 INFO - PROCESS | 1661 | Values: 141.0 108.0 106.0 141.0 109.0 105.0 108.0 108.0 127.0 105.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:2.20 (1.2%) stddev-sans-first:2.24 15:47:16 INFO - PROCESS | 1661 | Values: 185.0 186.0 184.0 182.0 179.0 183.0 183.0 183.0 181.0 186.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:65.20 Median:59.00 stddev:11.19 (19.0%) stddev-sans-first:10.09 15:47:16 INFO - PROCESS | 1661 | Values: 82.0 59.0 58.0 87.0 59.0 59.0 59.0 58.0 73.0 58.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:74.10 Median:75.50 stddev:6.95 (9.2%) stddev-sans-first:6.91 15:47:16 INFO - PROCESS | 1661 | Values: 81.0 69.0 85.0 70.0 69.0 68.0 81.0 67.0 70.0 81.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.90 (2.2%) stddev-sans-first:2.00 15:47:16 INFO - PROCESS | 1661 | Values: 88.0 87.0 90.0 86.0 89.0 85.0 90.0 85.0 88.0 86.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:93.50 stddev:18.08 (19.3%) stddev-sans-first:18.94 15:47:16 INFO - PROCESS | 1661 | Values: 94.0 92.0 95.0 98.0 94.0 90.0 132.0 140.0 93.0 93.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:86.50 stddev:2.59 (3.0%) stddev-sans-first:2.74 15:47:16 INFO - PROCESS | 1661 | Values: 87.0 86.0 85.0 87.0 88.0 85.0 85.0 84.0 85.0 93.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.77 (3.2%) stddev-sans-first:1.86 15:47:16 INFO - PROCESS | 1661 | Values: 55.0 52.0 52.0 54.0 55.0 56.0 57.0 55.0 55.0 52.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:4.44 (6.3%) stddev-sans-first:4.49 15:47:16 INFO - PROCESS | 1661 | Values: 66.0 81.0 71.0 72.0 70.0 67.0 67.0 67.0 70.0 67.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:6.09 (7.2%) stddev-sans-first:6.46 15:47:16 INFO - PROCESS | 1661 | Values: 86.0 82.0 80.0 83.0 81.0 82.0 86.0 88.0 88.0 101.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:138.00 stddev:11.14 (8.1%) stddev-sans-first:11.63 15:47:16 INFO - PROCESS | 1661 | Values: 142.0 134.0 131.0 129.0 124.0 154.0 127.0 126.0 152.0 146.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:164.00 stddev:6.02 (3.7%) stddev-sans-first:6.25 15:47:16 INFO - PROCESS | 1661 | Values: 165.0 164.0 165.0 164.0 160.0 163.0 161.0 164.0 164.0 145.0 15:47:16 INFO - PROCESS | 1661 | 15:47:16 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:67.50 stddev:7.78 (11.5%) stddev-sans-first:8.00 15:47:16 INFO - PROCESS | 1661 | Values: 64.0 64.0 63.0 63.0 64.0 67.0 68.0 78.0 82.0 81.0 15:47:16 INFO - PROCESS | 1661 | -------- Summary: end -------- 15:47:16 INFO - PROCESS | 1661 | 15:47:17 INFO - TEST-INFO | 1661: exit 0 15:47:17 INFO - TEST-OK | kraken | took 57776ms 15:47:17 INFO - SUITE-END | took 1175s 15:47:18 INFO - Completed test suite (00:19:35) 15:47:18 INFO - javascript benchmark 15:47:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3451.154467155547, 3457.6023757267913, 3458.446648536233, 3476.5480487536615, 3517.859285628575, 5726.198332233485, 5740.483356497914, 5751.453611906867, 5767.625104368213, 5775.855603609906, 5730.713464326788, 5804.854878628036, 5815.127730840376, 5821.970890145543, 5832.0, 5016.598672106241, 5188.740562971846, 5234.947650523503, 5265.183896496049, 5298.523132918037, 5134.204198349262, 5158.226266060102, 5169.121249387595, 5318.282031925679, 5325.866853328678, 5203.86990325243, 5234.790608375661, 5244.187150991603, 5264.131418315973, 5321.547668448186, 5292.073887069748, 5302.151655735083, 5306.965141797332, 5312.442193569658, 5313.946860531422, 5125.38495380553, 5172.0, 5250.684958902478, 5277.0, 5316.734163291859, 5630.493255606974, 5636.774529018834, 5647.209390685307, 5721.971390143022, 5741.827745167651, 6196.566240363177, 6267.185265915402, 6271.560990730651, 6280.874382512324, 6283.497320214372, 6242.344553821828, 6283.8114856554375, 6289.528285378569, 6308.810735677937, 6310.5898116622275, 5730.169125476783, 5774.307083150007, 5780.306363236438, 5842.386549412336, 5850.151727999416, 6259.0, 6295.685215739195, 6323.683815809191, 6372.330905254974, 6400.103985442041, 6245.906311405332, 6255.74977000924, 6264.404881536247, 6269.435750782452, 6276.529260305495, 5184.300119483897, 6235.844103897439, 6263.404976527223, 6291.930371836799, 6317.399847014526, 6132.5084813409785, 6169.043798211284, 6186.907196392058, 6198.194234749454, 6218.036204388327, 6270.529710271748, 6284.654344011124, 6294.181756371642, 6296.275928268308, 6300.117983482316, 5011.0, 5011.874703132378, 5013.1227035268685, 5032.924506132411, 5046.4953504649975, 4466.0, 4480.439945006874, 4482.0, 4497.302918047708, 4561.612262957619, 5832.88334233313, 5911.645301281937, 5929.555283353766, 5937.881242375129, 6042.4561789438285, 6281.96859015702, 6297.055441683784, 6304.684765761694, 6311.147995020705, 6320.020396838498, 5953.255843019622, 5953.583249172516, 5978.0, 5986.194918172653, 6002.249718785152, 5422.674639521562, 5430.8913821723345, 5441.5374693151525, 5542.2795036644975, 5554.583406244547, 6282.654454004982, 6295.433410993032, 6325.9051114233325, 6382.808515744535, 6411.230652321565, 6255.593386429868, 6293.559450838397, 6293.685315734287, 6295.0, 6299.118123462627, 6207.472364849038, 6383.968080159755, 6389.97760358359, 6403.871922561616, 6435.195600549931, 6058.303295120942, 6186.4741496973265, 6187.288461826947, 6214.937850621617, 6273.905891411541, 6285.088662143872, 6292.716827742671, 6299.4645455135, 6303.275123360872, 6305.180326557518, 4844.8304309349005, 6207.286162091417, 6221.222347206599, 6232.283287421823, 6247.5001999840815, 6052.697365131814, 6108.342071131602, 6114.144019837316, 6124.479419249235, 6144.723487442986, 6086.239220097488, 6109.266887973294, 6111.724972376165, 6133.447989680772, 6142.385761423822, 6199.450137465634, 6221.346758590283, 6227.875442491216, 6235.719392627252, 6238.126662267196, 5926.7925622603, 5942.078977758454, 6002.099685047103, 6018.157457955977, 6054.606450580698], "value": 5761.795645931985, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.23084180731723, 489.7624652043758, 511.6137316326173, 529.8436961096476, 535.4324416118911, 32274.0, 36056.639433605655, 42529.362059569095, 44203.77898110513, 45840.54159458404, 45392.86517837056, 45906.540934590645, 45913.85215369609, 46033.7698311508, 46089.769551152196, 9083.636654533811, 9438.76403089923, 9663.95168024159, 9678.9837067108, 9685.322027458045, 9072.183503484684, 11899.64301070965, 12038.759224815498, 12078.0, 12293.754124917496, 12028.037756979464, 12099.153059285854, 12103.939480302586, 12105.213161144497, 12105.455254513525, 11928.880711192864, 12002.0, 12002.339871307075, 12002.939985300018, 12015.978641815456, 11793.941030294794, 11888.167828252026, 11896.0, 11908.761824763456, 11914.0, 41865.0, 42038.78980605108, 42074.57925420737, 42143.0, 42167.78916105431, 4086.7752273624938, 4136.296829538986, 4149.771762553059, 4165.854195103157, 4179.832806687728, 30935.38129237425, 31613.051608451784, 32622.347553048807, 32917.50623740646, 33235.011798584324, 3253.886113985999, 3419.26485805553, 3422.845971931269, 3430.519727238189, 3455.1189446690933, 514875.42562287324, 515229.0, 516535.9999999962, 516626.0, 522290.0, 65177.0, 65509.0, 65540.68918621601, 65598.0, 65603.0, 68141.3185868135, 68269.65865170643, 68372.0, 68489.31510684929, 68519.31480685229, 17689.911550442164, 17901.19444624995, 17949.371771987917, 17968.550786230448, 17989.460316190536, 12499.812502812465, 12819.0, 13494.0, 13616.046876718534, 13631.0, 18642.889785969866, 23230.883845581004, 23301.7669823303, 23311.88344058269, 23348.533029339316, 8900.42147260426, 9046.185843274005, 9061.59222834974, 9062.320325975577, 9140.115450933326, 883.2492381475694, 891.7101941868918, 901.8241442918568, 936.2930987104828, 946.9952650236843, 31687.841560792047, 31952.840235799136, 32121.196970075936, 32310.83844580762, 33116.503252451235, 945.6831961292906, 1095.780843831237, 1109.5062697099713, 1118.2284223885492, 1206.7164216409137, 15898.364065437485, 16178.433754818525, 16305.59236019109, 16345.42791002333, 16715.414960476326, 670733.0, 677561.0, 678901.0, 679006.0, 680534.0, 59702.80594388088, 59706.70146649239, 59750.70124649349, 59847.40152598506, 59849.803003939676, 1391.979120313196, 1436.2746812859439, 1515.9621009474852, 1548.5896237497072, 1563.5543869996995, 31332.686673132976, 32967.83516082404, 33095.50356744699, 33297.167570810925, 33777.662223377454, 54728.0, 55158.0, 55256.72371638116, 55394.0, 55470.72264638651, 577193.0, 581697.0, 582214.0, 582508.0, 583467.5786347458, 36458.63541364553, 37904.951480467775, 38344.849654510406, 39064.023399415244, 45757.54242457533, 40000.0, 49069.75465122652, 49409.50590494049, 50276.245856311456, 51307.0, 34266.45697596026, 34348.14129646779, 34514.96455106351, 35052.64947350596, 35615.75344862918, 34195.0, 34432.0, 35125.94622161339, 35383.46924796182, 35463.645363546035, 39898.40152397774, 40908.1818363637, 41028.589714102476, 41060.384094239205, 41108.79445602753, 27072.781724822038, 33242.33515329631, 33288.33423331568, 33561.16097097495, 35290.470642939865, 26274.21177364682, 26473.602895956963, 26517.867410663595, 26540.0, 27092.0], "value": 21554.6396999934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.0334910811794, 399.2354640862748, 403.8889305441005, 409.3123552431917, 437.07994671217085, 20802.99999999998, 21790.01944912479, 21953.40769759863, 22140.33578992633, 22184.0, 21675.45811354717, 22053.669194962087, 22415.439614009658, 23469.0, 23582.93876775549, 5896.646201227929, 6186.7525298987985, 6204.751809927598, 6206.472449841769, 6213.627182369072, 5725.026745453262, 5769.3076830780365, 6083.422074902899, 6131.110988906628, 6143.986242270043, 5930.703464826763, 6075.362086980869, 6080.452759251666, 6084.026555751081, 6085.939140608603, 5936.287645482548, 5996.730147143389, 6066.908996365058, 6074.726637301332, 6089.634621922699, 5148.382194136728, 5308.071087559701, 5325.281087053237, 5328.573714102862, 5334.946650533522, 27732.8906843726, 27742.583861241896, 27743.670759508786, 27750.02874899369, 28002.01992930258, 2802.7897907657007, 2805.551111822099, 2822.167639542167, 2843.829370237772, 2925.195571217911, 15829.762553561706, 15954.122523261216, 16088.839111608851, 16232.513024609281, 16398.761980830695, 1665.4420769042385, 1864.655038817823, 1940.7768106667772, 1960.7941166177632, 1963.0, 114458.0, 118495.0, 119025.0, 119877.0, 119979.0, 11401.657950261506, 11648.0, 11727.648170554898, 11758.823617645741, 11965.222260553037, 14952.775708364383, 14982.250887455584, 14988.175650339335, 14991.250437478082, 15035.173065481285, 7652.852072189105, 8696.869546956801, 9004.234640055538, 9031.50326732023, 9148.130927561871, 9033.793003483801, 9038.322125840588, 9050.230730387859, 9099.863502047343, 9185.494797786187, 7181.8922716159295, 7302.2697730226555, 7308.30571095745, 7310.963445182846, 7335.266473352622, 1976.6837306030966, 2002.2991952816399, 2002.929897453582, 2003.0986056274735, 2004.2684420186526, 1027.2860362048305, 1055.9155267578576, 1072.4691277817374, 1078.5092782783815, 1133.4332833583208, 21667.0, 23004.19485318006, 23590.0, 23899.7610023901, 23915.880420597787, 888.8311220868014, 963.0738522954092, 1094.7317907112808, 1126.5775334249656, 1127.1602656021316, 8660.78348041304, 10754.731131721614, 11172.938570835757, 11191.384473853854, 11216.214864959375, 652236.0, 732570.0, 794370.0, 799024.0, 810697.0, 147563.0, 149176.0, 157893.2105339466, 160036.19981900015, 175152.0, 457.1702360216197, 461.8614415675284, 475.27520531190214, 478.3207844860307, 479.7673128532659, 11407.486663100015, 11600.361980091177, 11636.858048327074, 11816.645500634995, 12068.034557235576, 48096.7595162022, 54147.729261353445, 62379.0, 63153.05270421039, 63526.0, 91948.78179263693, 92418.15163696554, 92827.53586232026, 94200.52899735457, 94822.0, 8587.613557390057, 8688.218060374596, 8800.559972001502, 8995.55022248898, 9136.406133601295, 10869.456527173452, 13539.796903046265, 13596.184228946295, 13685.726285474433, 13996.580102596938, 11619.186656934271, 11645.068394528587, 12063.698407539881, 12074.39628018613, 12125.0, 10003.849557300713, 10372.17022638172, 10822.621208257673, 10894.400807955322, 11459.885401145882, 11313.830292545783, 11463.713407164887, 11907.821382679094, 11908.285502869856, 12220.266783992989, 8774.956125219333, 8836.91163088361, 9104.772380690536, 9110.544472776468, 9128.224100951227, 10088.64689735885, 11597.594084207012, 11772.293662380285, 11987.981021613261, 12293.262404255773], "value": 10101.31567351304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.055347087246, 1468.65617959567, 1485.6434455730625, 1493.3205391546853, 1504.3456096597977, 7674.50115742477, 8032.317253033492, 8305.252527272543, 8556.74329770108, 8563.400561960665, 8483.448575842565, 8523.0, 8563.785905352353, 8564.357673174505, 8566.742997710064, 2363.6809030780882, 2398.9760102398927, 2403.6034054381007, 2404.3027522018683, 2405.5669979403788, 2156.8490205685607, 2232.10715713715, 2361.126383238204, 2376.0970831084164, 2440.8535487870786, 2394.4971555973266, 2399.892004859777, 2400.2679182849224, 2403.555342261687, 2407.0973384980634, 2357.752435994213, 2375.798057165134, 2381.1784934197676, 2385.0221409222136, 2386.331827088418, 2357.7642235776457, 2390.5577468168444, 2393.2939782764124, 2401.591729406005, 2402.555527227451, 8581.95709021451, 8645.783855403603, 8668.52323122228, 8669.869951950663, 8676.696315628986, 5228.189630607262, 5387.838364849061, 5395.757190926418, 5400.78396864125, 5406.756695948692, 3474.1314671332166, 3640.308341415123, 3685.0971511979737, 3692.9446058309145, 3699.9445008324897, 1134.4214450630157, 1156.8149096144577, 1172.7654469106128, 1271.396086858744, 1297.9221246725226, 10916.01755841978, 10963.945180274048, 11106.777864442665, 11115.499802508906, 11117.055050320732, 4734.360861283752, 4748.2543182653435, 4769.618430525549, 4842.757862106881, 4862.95137048632, 9764.951175244078, 9775.364601301035, 9783.0, 9790.657326993522, 9795.902040979641, 4786.827227329327, 5240.213967904845, 5296.417394086648, 5339.626226164131, 5442.510174084351, 4859.635527335464, 4915.410150781858, 4974.77613507393, 4987.850364489072, 5001.72490513018, 3704.795941319082, 3837.059920319484, 3837.13664425502, 3969.4045893115685, 4040.454538637305, 1287.0861688201483, 1290.5031562848183, 1295.6760809797552, 1302.947882084725, 1308.8363954505687, 908.5593487158723, 920.9777147366418, 932.7481579973505, 933.6685476655825, 981.0238812381583, 5594.748236329375, 5656.43435656431, 5847.44449277318, 5989.8203053908455, 6071.908921366095, 1004.598160735697, 1017.4810846468206, 1017.699778565325, 1025.7486915705551, 1057.3074636113358, 3235.223546348859, 3285.5400243965864, 3637.8544858205373, 3878.864239751595, 4038.757674539537, 9746.269029822792, 10046.14607758334, 10179.949100254451, 10322.22583306255, 10327.173826093895, 9775.364601300893, 10099.69700908974, 10290.382577045251, 10309.381437113798, 10311.793764124675, 7900.0, 8173.836523269501, 8191.303739182117, 8193.303569196565, 8194.30348420379, 5814.3604203538425, 5862.648241105548, 5885.0, 6021.277446706424, 6094.8171554853425, 9360.11078947499, 9482.762930926781, 9505.42967421957, 9508.28687848428, 9523.714288571355, 9248.537573121452, 9570.712878613653, 9585.185259253041, 9596.808063838824, 9659.951700241454, 7795.181505941794, 7988.320992715684, 8055.959720201596, 8058.556779377191, 8062.8790568142695, 7865.567393793167, 7921.207879212033, 7946.40401969843, 7968.7609371718945, 8010.0, 6988.859421724809, 7025.946108083828, 7046.436285097077, 7064.823379415556, 7139.892901606376, 6947.930520694728, 6987.6855541499735, 6992.706778552702, 7042.507024508235, 7171.641417928979, 6451.032345148265, 6506.186726659168, 6591.5056370773345, 6593.109930159367, 6604.669766511752, 5025.723585202849, 5180.352455943007, 5181.611379146504, 5232.424433312256, 5308.875528658989, 5071.568916642127, 5169.741512924414, 5179.274901513866, 5248.396434410091, 5384.946150538444], "value": 4562.653033972408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.95680518337787, 363.5728019576997, 374.7021118211022, 380.6840322532299, 382.8181613733479, 5154.74226288686, 5348.304720386354, 5409.702466364353, 5430.8913821723545, 5485.616006879515, 4818.42178938527, 5248.291480650111, 5316.016536940669, 5316.033067764933, 5400.405955344909, 3518.700910422617, 3741.9625803741887, 3865.942010869839, 4229.978850105746, 4288.69979101463, 4103.651189648884, 4220.810063547133, 4230.217409779185, 4273.871783846474, 4314.697971142005, 3522.4011917974008, 3673.3938900081453, 4098.077932465187, 4267.1892340455215, 4311.0, 4199.181159673864, 4226.450561426995, 4232.597903199191, 4244.19360321541, 4245.15096980602, 3150.928684247344, 3341.2124513385465, 3812.3137835189655, 3836.290286297044, 3855.8457661693496, 4500.572445617661, 4891.779869905863, 5253.86865328366, 5273.709945952971, 5295.708736019517, 3734.8982050295226, 4768.926991426936, 4947.332110165117, 4950.9504904950845, 4962.801487940478, 5017.899642007176, 5621.690807005613, 5696.572757043238, 5744.712764361807, 5745.563609097726, 3530.382183117944, 3697.759645623026, 3922.235164142993, 4182.121754431573, 4255.468066491689, 5964.343922168558, 5998.890759829531, 6003.0695242237525, 6023.45788879003, 6028.336882942873, 3822.8722526854644, 4326.329418940069, 4330.7401555906745, 4332.1371810121955, 4344.847930322424, 3492.633273506296, 4297.484301883732, 4344.478662560513, 4346.174226896879, 4377.409049778239, 4081.4286499697832, 4843.15244832153, 4900.485449027872, 4926.408830940239, 4927.482614325516, 5517.723764082868, 5549.6115271931385, 5832.0, 5836.416358364215, 5850.460471414818, 1282.410091357967, 1320.214472388927, 1325.6553296143072, 1335.3256605414397, 1423.0892228973464, 919.6551293265026, 990.811026767867, 998.8912307338848, 1004.50779118233, 1005.6027868991707, 4518.864434066917, 4523.592876641118, 4536.591706746409, 5030.8239211627415, 5063.30378823461, 4967.820594819318, 5246.16061430177, 5518.144687573433, 5540.556755459554, 5554.583406244547, 4060.878173654795, 4061.6750659947133, 5033.899322013539, 5043.3443652325695, 5065.569426598707, 2466.703995520513, 2526.9747302527107, 2643.2598872315784, 2716.5381885079582, 2934.9874293368753, 4778.402699662543, 5307.734613269321, 5639.0, 5703.857403564944, 5809.663777331153, 5273.156294992783, 5358.758855851496, 5428.375736790241, 5739.62692424991, 5753.942460575425, 5222.451642577551, 5490.066688662937, 5758.62568933018, 5786.826395208066, 5789.247397838254, 5442.727863606725, 5482.013237617267, 5568.9443105568425, 5569.79736651419, 5590.496855283044, 4792.447175183659, 5274.89450210986, 5298.44366341544, 5500.5973476763165, 5568.721563921707, 5092.719900405513, 5714.257146570919, 5743.224664670216, 5753.913691294718, 5798.971005144947, 3703.833327500323, 3718.925621487609, 3728.0120767997046, 3728.366177749735, 3763.623637636324, 4652.534746525455, 4915.852524424273, 5509.173623956278, 5534.0, 5600.243967064394, 5505.256790333414, 5537.501624853782, 5543.805966791143, 5643.560891972521, 5676.68778217202, 4745.905081898273, 4822.469528351809, 5660.235868157746, 5664.631798933056, 5681.914686355771, 5160.0, 5254.894902102013, 5498.890022199454, 5560.610757246954, 5596.424201563228, 5676.262085928803, 5681.431856814285, 5682.062459694104, 5701.800436984686, 5707.7716891325545, 4505.842295519641, 4615.538446155358, 5097.949020509747, 5531.225628412106, 5597.496225339739], "value": 4138.318257963643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.5874713597707, 757.56440046973, 792.8493586218618, 859.6819176904544, 877.4954401219296, 15348.769768453469, 16017.439389621366, 16089.0, 16098.758518622215, 16161.919190404062, 12313.0, 14961.251937403113, 15004.774928376082, 15021.849781502182, 15033.248337583105, 699.7375984005997, 723.0094770164882, 884.5577211394303, 894.0657013420958, 898.5417437107058, 732.6263605561148, 851.9829603407928, 885.0706757904208, 886.5168483176652, 888.0675290944515, 950.8573713942894, 960.5677445149676, 963.3208587945481, 966.3284017607765, 967.5791030901545, 962.629387685746, 962.7593101724569, 962.9133377995944, 966.8259713251612, 967.5887747707231, 602.7860109661051, 714.3891972363606, 717.1394326807851, 717.408138285911, 717.7236763845905, 15313.770293445607, 15797.0, 15823.525294241192, 16076.839231607768, 16226.269817858225, 14579.781303280459, 14731.189784561844, 14780.926095369454, 14858.628534286729, 14894.925525372411, 11557.422128893522, 11743.882561174365, 11760.882391176065, 11784.528618855236, 12326.383680815923, 3969.9007524811823, 4048.878533643966, 4089.8773036808943, 4098.057446787256, 4098.180363927227, 105889.0, 106302.0, 106879.99999999923, 107519.46240268827, 111158.0, 9802.411855288705, 11332.64008319007, 11459.197856150156, 11528.135389845795, 11587.594434194763, 23632.0, 23643.408914776923, 23654.7634523656, 24066.39834004164, 24077.51844963126, 7748.806279843049, 8014.118446970829, 8043.235892590312, 8074.3540516759695, 8091.514509129471, 4394.780260986938, 4394.8242070317465, 4422.513523512411, 4512.255477846119, 4581.770911454414, 3711.0907827582414, 3782.678472329828, 3805.06775839921, 3818.866339678098, 3832.3101841668768, 680.4930326906486, 681.8363592737807, 686.8694947959872, 700.0339531446571, 712.576017269734, 666.6966530228734, 677.2347247610169, 701.8982247574073, 701.9719211231494, 732.3701616609711, 10185.592576296865, 10236.821244550169, 10289.691309260734, 10462.68611941643, 10464.52909619069, 684.1516519515864, 698.4168219536642, 702.8980797784293, 724.1708244060521, 725.3399406540024, 4973.90052198954, 5065.290859279704, 5071.54356107952, 5078.949210507922, 5088.516590923857, 72317.0, 87337.12662873417, 94222.58666120014, 101896.0, 105534.4723276394, 69177.0, 84227.73658395007, 84408.57795711105, 86143.0, 86915.0, 59599.80800383968, 63483.0, 65914.0, 74901.25098748943, 75760.86358704514, 9644.911252561327, 9656.115457216169, 9703.417794932328, 9765.511724413609, 9769.80460390774, 48217.75891120522, 49365.25952110649, 50540.0, 50606.2409063857, 51159.48840511547, 57949.420505794405, 59611.0, 61759.38240617716, 65504.01743973939, 66745.66627166833, 13630.591082267549, 13747.931260343634, 13785.140160755005, 14043.859561404255, 14059.156450612996, 14191.219482928538, 14910.701785964437, 15435.61410964735, 15815.0, 15873.52379428619, 13340.799888001493, 14090.718185636435, 14365.7845132321, 14405.06367086136, 14804.037737547456, 13716.725665486834, 14141.929290353482, 14206.857931420553, 14250.643733906736, 14695.632609184855, 13148.408321625358, 13961.860381396056, 14124.223167725462, 14221.573352799433, 14588.197649129399, 9789.216862651114, 10564.366138031743, 10623.415712135908, 10955.178361622751, 10968.0, 10890.509927053143, 11136.10911127124, 11422.657320280405, 11646.941765291458, 11876.168668193144], "value": 7673.827331133012, "unit": "score"}], "name": "dromaeo_css", "value": 7526.559324594859, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 111.0, 114.0, 115.0, 114.0, 114.0, 115.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 106.0, 141.0, 109.0, 105.0, 108.0, 108.0, 127.0, 105.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 184.0, 182.0, 179.0, 183.0, 183.0, 183.0, 181.0, 186.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 87.0, 59.0, 59.0, 59.0, 58.0, 73.0, 58.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 69.0, 85.0, 70.0, 69.0, 68.0, 81.0, 67.0, 70.0, 81.0], "value": 74.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 86.0, 89.0, 85.0, 90.0, 85.0, 88.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 95.0, 98.0, 94.0, 90.0, 132.0, 140.0, 93.0, 93.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 87.0, 88.0, 85.0, 85.0, 84.0, 85.0, 93.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 54.0, 55.0, 56.0, 57.0, 55.0, 55.0, 52.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 71.0, 72.0, 70.0, 67.0, 67.0, 67.0, 70.0, 67.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 80.0, 83.0, 81.0, 82.0, 86.0, 88.0, 88.0, 101.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 131.0, 129.0, 124.0, 154.0, 127.0, 126.0, 152.0, 146.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 164.0, 160.0, 163.0, 161.0, 164.0, 164.0, 145.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 67.0, 68.0, 78.0, 82.0, 81.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1404.3999999999999, "alertThreshold": 2.0}]} 15:47:18 INFO - Return code: 0 15:47:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:47:18 INFO - # TBPL SUCCESS # 15:47:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:47:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:47:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:47:18 INFO - 2017-04-07 15:47:18.258 screenresolution[1665:9669] starting screenresolution argv=screenresolution get 15:47:18 INFO - 2017-04-07 15:47:18.261 screenresolution[1665:9669] Display 0: 1600x1200x32@60 15:47:18 INFO - 2017-04-07 15:47:18.267 screenresolution[1666:9672] starting screenresolution argv=screenresolution list 15:47:18 INFO - Available Modes on Display 0 15:47:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:47:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:47:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:47:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:47:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:47:18 INFO - Intel Iris: 15:47:18 INFO - Chipset Model: Intel Iris 15:47:18 INFO - Type: GPU 15:47:18 INFO - Bus: Built-In 15:47:18 INFO - VRAM (Dynamic, Max): 1536 MB 15:47:18 INFO - Vendor: Intel (0x8086) 15:47:18 INFO - Device ID: 0x0a2e 15:47:18 INFO - Revision ID: 0x0009 15:47:18 INFO - Displays: 15:47:18 INFO - Display: 15:47:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:47:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:47:18 INFO - Display Serial Number: 1600x1200 60 15:47:18 INFO - Main Display: Yes 15:47:18 INFO - Mirror: Off 15:47:18 INFO - Online: Yes 15:47:18 INFO - Rotation: Supported 15:47:18 INFO - Return code: 0 15:47:18 INFO - Running post-action listener: _resource_record_post_action 15:47:18 INFO - [mozharness: 2017-04-07 22:47:18.501828Z] Finished run-tests step (success) 15:47:18 INFO - Running post-run listener: _resource_record_post_run 15:47:18 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 39199744; Write bytes: 419620864; Read time: 380; Write time: 1406 15:47:18 INFO - TinderboxPrint: CPU usage
53.5% 15:47:18 INFO - TinderboxPrint: I/O read bytes / time
39,199,744 / 380 15:47:18 INFO - TinderboxPrint: I/O write bytes / time
419,620,864 / 1,406 15:47:18 INFO - TinderboxPrint: CPU idle
2,215.6 (46.5%) 15:47:18 INFO - TinderboxPrint: CPU system
949.8 (19.9%) 15:47:18 INFO - TinderboxPrint: CPU user
1,600.1 (33.6%) 15:47:18 INFO - TinderboxPrint: Swap in / out
160,620,544 / 0 15:47:18 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122774016; Write bytes: 122474496; Read time: 11091; Write time: 249 15:47:18 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34456576; Write bytes: 295626752; Read time: 346; Write time: 1150 15:47:18 INFO - Running post-run listener: _upload_blobber_files 15:47:18 INFO - Blob upload gear active. 15:47:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:18 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 15:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:47:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:20 INFO - (blobuploader) - INFO - Done attempting. 15:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:21 INFO - (blobuploader) - INFO - Done attempting. 15:47:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:47:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:47:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:22 INFO - (blobuploader) - INFO - Done attempting. 15:47:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:47:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:47:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:25 INFO - (blobuploader) - INFO - Done attempting. 15:47:25 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:25 INFO - Return code: 0 15:47:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fab1e35cbf1ee0e8b92bb6d685ec9f501bcb4635f0d6ded630ea40b47950aef7a14fbecca5887b54b7d6311ff478e60298dd53cbfc4ee53bd060aa20af99db42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6ed13b664676ee8d8d485f1a5fd91fd6dd0b5b3987aa78d624a072b12469e722c408e5148b776914af485a27c0af6f13cd63fa45e77adf5f2ac22255ec63a7f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7ab6333c8ae0f1e5363da332a32bda53bdf59250f9ef0533b77e9eeb1770d22cf38394c3d050eef40cc893641a14abc297dd8f301f4e34a779f1f8afdb0bae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8bf0678fbdb9f56e216129d1f6daed39f4aef15cd8b061804cf26ea3474d6f742f4737b31c8fe196456357e0e9ad2dadb7e2029eb5931f567d56963deca6ba5"} 15:47:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:25 INFO - Contents: 15:47:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fab1e35cbf1ee0e8b92bb6d685ec9f501bcb4635f0d6ded630ea40b47950aef7a14fbecca5887b54b7d6311ff478e60298dd53cbfc4ee53bd060aa20af99db42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6ed13b664676ee8d8d485f1a5fd91fd6dd0b5b3987aa78d624a072b12469e722c408e5148b776914af485a27c0af6f13cd63fa45e77adf5f2ac22255ec63a7f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7ab6333c8ae0f1e5363da332a32bda53bdf59250f9ef0533b77e9eeb1770d22cf38394c3d050eef40cc893641a14abc297dd8f301f4e34a779f1f8afdb0bae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8bf0678fbdb9f56e216129d1f6daed39f4aef15cd8b061804cf26ea3474d6f742f4737b31c8fe196456357e0e9ad2dadb7e2029eb5931f567d56963deca6ba5"} 15:47:25 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:25 INFO - Copying logs to upload dir... 15:47:25 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.408907 ========= master_lag: 2.70 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-04-07 15:47:27.875132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 15:47:27.878321) ========= 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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fab1e35cbf1ee0e8b92bb6d685ec9f501bcb4635f0d6ded630ea40b47950aef7a14fbecca5887b54b7d6311ff478e60298dd53cbfc4ee53bd060aa20af99db42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6ed13b664676ee8d8d485f1a5fd91fd6dd0b5b3987aa78d624a072b12469e722c408e5148b776914af485a27c0af6f13cd63fa45e77adf5f2ac22255ec63a7f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7ab6333c8ae0f1e5363da332a32bda53bdf59250f9ef0533b77e9eeb1770d22cf38394c3d050eef40cc893641a14abc297dd8f301f4e34a779f1f8afdb0bae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8bf0678fbdb9f56e216129d1f6daed39f4aef15cd8b061804cf26ea3474d6f742f4737b31c8fe196456357e0e9ad2dadb7e2029eb5931f567d56963deca6ba5"} build_url:https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010955 build_url: 'https://queue.taskcluster.net/v1/task/brM_j4rTRhCVkG8Y30DX9Q/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fab1e35cbf1ee0e8b92bb6d685ec9f501bcb4635f0d6ded630ea40b47950aef7a14fbecca5887b54b7d6311ff478e60298dd53cbfc4ee53bd060aa20af99db42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6ed13b664676ee8d8d485f1a5fd91fd6dd0b5b3987aa78d624a072b12469e722c408e5148b776914af485a27c0af6f13cd63fa45e77adf5f2ac22255ec63a7f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7ab6333c8ae0f1e5363da332a32bda53bdf59250f9ef0533b77e9eeb1770d22cf38394c3d050eef40cc893641a14abc297dd8f301f4e34a779f1f8afdb0bae1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d8bf0678fbdb9f56e216129d1f6daed39f4aef15cd8b061804cf26ea3474d6f742f4737b31c8fe196456357e0e9ad2dadb7e2029eb5931f567d56963deca6ba5"}' ========= master_lag: 0.32 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 15:47:28.205878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:47:28.206222) ========= 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.lNxKuDeWbz/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.R9Chz6SMmO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005101 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 15:47:28.233429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 15:47:28.233721) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 15:47:28.234040) ========= ========= Total master_lag: 3.12 =========