builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1478326367.52 results: success (0) buildid: 20161104212320 builduid: 602bce568ab04e6ea043c056341b5faf revision: 69e17427242dc8063a7ad7d739247d4c47402da5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.515922) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.516392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.516685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.541511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.541900) ========= 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.PxoaWNNpys/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.UxQNJcb8kY/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-04 23:12:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.74M=0.001s 2016-11-04 23:12:47 (9.74 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.668158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.668469) ========= 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.PxoaWNNpys/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.UxQNJcb8kY/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.024723 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:47.768516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-04 23:12:47.768886) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69e17427242dc8063a7ad7d739247d4c47402da5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69e17427242dc8063a7ad7d739247d4c47402da5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PxoaWNNpys/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.UxQNJcb8kY/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-04 23:12:48,409 truncating revision to first 12 chars 2016-11-04 23:12:48,409 Setting DEBUG logging. 2016-11-04 23:12:48,409 attempt 1/10 2016-11-04 23:12:48,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/69e17427242d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 23:12:49,295 unpacking tar archive at: mozilla-aurora-69e17427242d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.149614 ========= master_lag: 0.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-04 23:12:49.622036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:49.622355) ========= script_repo_revision: 69e17427242dc8063a7ad7d739247d4c47402da5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:49.622748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:49.623024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 23:12:49.641452) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-04 23:12:49.641782) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PxoaWNNpys/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.UxQNJcb8kY/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:12:49 INFO - MultiFileLogger online at 20161104 23:12:49 in /builds/slave/test 23:12:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:12:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:12:49 INFO - {'append_to_log': False, 23:12:49 INFO - 'base_work_dir': '/builds/slave/test', 23:12:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:12:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:12:49 INFO - 'branch': 'Mozilla-Aurora', 23:12:49 INFO - 'buildbot_json_path': 'buildprops.json', 23:12:49 INFO - 'config_files': ('talos/mac_config.py',), 23:12:49 INFO - 'default_actions': ('clobber', 23:12:49 INFO - 'read-buildbot-config', 23:12:49 INFO - 'download-and-extract', 23:12:49 INFO - 'populate-webroot', 23:12:49 INFO - 'create-virtualenv', 23:12:49 INFO - 'install', 23:12:49 INFO - 'run-tests'), 23:12:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:12:49 INFO - 'download_minidump_stackwalk': True, 23:12:49 INFO - 'download_symbols': 'ondemand', 23:12:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:12:49 INFO - 'tooltool.py': '/tools/tooltool.py', 23:12:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:12:49 INFO - '/tools/misc-python/virtualenv.py')}, 23:12:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:12:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:12:49 INFO - 'installer_path': 'installer.exe', 23:12:49 INFO - 'log_level': 'info', 23:12:49 INFO - 'log_name': 'talos', 23:12:49 INFO - 'log_to_console': True, 23:12:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:12:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:12:49 INFO - 'opt_config_files': (), 23:12:49 INFO - 'pip_index': False, 23:12:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:12:49 INFO - 'cmd': ('bash', 23:12:49 INFO - '-c', 23:12:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:12:49 INFO - 'enabled': True, 23:12:49 INFO - 'halt_on_failure': False, 23:12:49 INFO - 'name': 'check_screen_resolution'},), 23:12:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:12:49 INFO - 'cmd': ('bash', 23:12:49 INFO - '-c', 23:12:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:12:49 INFO - 'enabled': True, 23:12:49 INFO - 'halt_on_failure': False, 23:12:49 INFO - 'name': 'check_screen_resolution'},), 23:12:49 INFO - 'run_cmd_checks_enabled': True, 23:12:49 INFO - 'sps_profile': False, 23:12:49 INFO - 'sps_profile_interval': 0, 23:12:49 INFO - 'suite': 'dromaeojs', 23:12:49 INFO - 'system_bits': '32', 23:12:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:12:49 INFO - 'title': 't-yosemite-r7-0345', 23:12:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:12:49 INFO - 'use_talos_json': True, 23:12:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:12:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:12:49 INFO - 'work_dir': 'build'} 23:12:49 INFO - [mozharness: 2016-11-05 06:12:49.842851Z] Running clobber step. 23:12:49 INFO - Running pre-action listener: _resource_record_pre_action 23:12:49 INFO - Running main action method: clobber 23:12:49 INFO - rmtree: /builds/slave/test/build 23:12:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:12:51 INFO - Running post-action listener: _resource_record_post_action 23:12:51 INFO - [mozharness: 2016-11-05 06:12:51.911043Z] Finished clobber step (success) 23:12:51 INFO - [mozharness: 2016-11-05 06:12:51.911250Z] Running read-buildbot-config step. 23:12:51 INFO - Running pre-action listener: _resource_record_pre_action 23:12:51 INFO - Running main action method: read_buildbot_config 23:12:51 INFO - Using buildbot properties: 23:12:51 INFO - { 23:12:51 INFO - "project": "", 23:12:51 INFO - "product": "firefox", 23:12:51 INFO - "script_repo_revision": "production", 23:12:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 23:12:51 INFO - "repository": "", 23:12:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 23:12:51 INFO - "buildid": "20161104212320", 23:12:51 INFO - "pgo_build": "False", 23:12:51 INFO - "basedir": "/builds/slave/test", 23:12:51 INFO - "buildnumber": 15, 23:12:51 INFO - "slavename": "t-yosemite-r7-0345", 23:12:51 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 23:12:51 INFO - "platform": "yosemite_r7", 23:12:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 23:12:51 INFO - "branch": "mozilla-aurora", 23:12:51 INFO - "repo_path": "releases/mozilla-aurora", 23:12:51 INFO - "revision": "69e17427242dc8063a7ad7d739247d4c47402da5", 23:12:51 INFO - "stage_platform": "macosx64", 23:12:51 INFO - "builduid": "602bce568ab04e6ea043c056341b5faf", 23:12:51 INFO - "slavebuilddir": "test" 23:12:51 INFO - } 23:12:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 23:12:51 INFO - Running post-action listener: _resource_record_post_action 23:12:51 INFO - [mozharness: 2016-11-05 06:12:51.916673Z] Finished read-buildbot-config step (success) 23:12:51 INFO - [mozharness: 2016-11-05 06:12:51.916878Z] Running download-and-extract step. 23:12:51 INFO - Running pre-action listener: _resource_record_pre_action 23:12:51 INFO - Running main action method: download_and_extract 23:12:51 INFO - mkdir: /builds/slave/test/build/tests 23:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:12:51 INFO - trying https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 23:12:51 INFO - Downloading https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 23:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 23:12:53 INFO - Downloaded 1199 bytes. 23:12:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 23:12:53 INFO - Using the following test package requirements: 23:12:53 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 23:12:53 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 23:12:53 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 23:12:53 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'jsshell-mac.zip'], 23:12:53 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 23:12:53 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 23:12:53 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 23:12:53 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 23:12:53 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 23:12:53 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 23:12:53 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 23:12:53 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 23:12:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 23:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 23:12:53 INFO - Fetch https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 23:12:53 INFO - Expected file size: 16421395 23:13:01 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 23:13:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 23:13:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 23:13:01 INFO - Fetch https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 23:13:01 INFO - Expected file size: 16421395 23:13:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 23:13:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 23:13:08 INFO - Fetch https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 23:13:08 INFO - Expected file size: 14414089 23:13: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')]} 23:13:09 INFO - trying https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 23:13:09 INFO - Downloading https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 23:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 23:13:12 INFO - Downloaded 115455977 bytes. 23:13:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 23:13:12 INFO - mkdir: /builds/slave/test/properties 23:13:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:13:12 INFO - Writing to file /builds/slave/test/properties/build_url 23:13:12 INFO - Contents: 23:13:12 INFO - build_url:https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 23:13:12 INFO - Running post-action listener: _resource_record_post_action 23:13:12 INFO - Running post-action listener: set_extra_try_arguments 23:13:12 INFO - [mozharness: 2016-11-05 06:13:12.930965Z] Finished download-and-extract step (success) 23:13:12 INFO - [mozharness: 2016-11-05 06:13:12.931111Z] Running populate-webroot step. 23:13:12 INFO - Running pre-action listener: _resource_record_pre_action 23:13:12 INFO - Running main action method: populate_webroot 23:13:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:13:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:13:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:13:12 INFO - '--tppagecycles', 23:13:12 INFO - '7'], 23:13:12 INFO - 'tests': ['tsvgm']}}, 23:13:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:13:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:13:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:13:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:13:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:13:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:13:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['damp', 'tps']}, 23:13:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'tests': ['damp', 'tps']}, 23:13:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['dromaeo_dom']}, 23:13:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:13:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['basic_compositor_video']}, 23:13:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:13:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['a11yr', 23:13:12 INFO - 'ts_paint', 23:13:12 INFO - 'tpaint', 23:13:12 INFO - 'sessionrestore', 23:13:12 INFO - 'sessionrestore_no_auto_restore', 23:13:12 INFO - 'tabpaint']}, 23:13:12 INFO - 'other-e10s': {'tests': ['a11yr', 23:13:12 INFO - 'ts_paint', 23:13:12 INFO - 'tpaint', 23:13:12 INFO - 'sessionrestore', 23:13:12 INFO - 'sessionrestore_no_auto_restore', 23:13:12 INFO - 'tabpaint']}, 23:13:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:13:12 INFO - 'ts_paint', 23:13:12 INFO - 'tpaint', 23:13:12 INFO - 'sessionrestore', 23:13:12 INFO - 'sessionrestore_no_auto_restore', 23:13:12 INFO - 'tabpaint']}, 23:13:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:13:12 INFO - 'ts_paint', 23:13:12 INFO - 'tpaint', 23:13:12 INFO - 'sessionrestore', 23:13:12 INFO - 'sessionrestore_no_auto_restore', 23:13:12 INFO - 'tabpaint']}, 23:13:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['a11yr', 23:13:12 INFO - 'ts_paint', 23:13:12 INFO - 'tpaint', 23:13:12 INFO - 'sessionrestore', 23:13:12 INFO - 'sessionrestore_no_auto_restore', 23:13:12 INFO - 'tabpaint']}, 23:13:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['a11yr', 23:13:12 INFO - 'ts_paint', 23:13:12 INFO - 'tpaint', 23:13:12 INFO - 'sessionrestore', 23:13:12 INFO - 'sessionrestore_no_auto_restore', 23:13:12 INFO - 'tabpaint']}, 23:13:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['tsvgx', 23:13:12 INFO - 'tsvgr_opacity', 23:13:12 INFO - 'tart', 23:13:12 INFO - 'tscrollx', 23:13:12 INFO - 'cart']}, 23:13:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:13:12 INFO - 'tsvgr_opacity', 23:13:12 INFO - 'tart', 23:13:12 INFO - 'tscrollx', 23:13:12 INFO - 'cart']}, 23:13:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'talos_options': ['--disable-e10s'], 23:13:12 INFO - 'tests': ['tp5o']}, 23:13:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'tests': ['tp5o']}, 23:13:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'talos_options': ['--disable-e10s', 23:13:12 INFO - '--xperf_path', 23:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:13:12 INFO - 'tests': ['tp5n']}, 23:13:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:13:12 INFO - 'talos_options': ['--xperf_path', 23:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:13:12 INFO - 'tests': ['tp5n']}}, 23:13:12 INFO - 'talos.zip': {'path': '', 23:13:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:13:12 INFO - Running post-action listener: _resource_record_post_action 23:13:12 INFO - [mozharness: 2016-11-05 06:13:12.950052Z] Finished populate-webroot step (success) 23:13:12 INFO - [mozharness: 2016-11-05 06:13:12.950186Z] Running create-virtualenv step. 23:13:12 INFO - Running pre-action listener: _resource_record_pre_action 23:13:12 INFO - Running main action method: create_virtualenv 23:13:12 INFO - Creating virtualenv /builds/slave/test/build/venv 23:13:12 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 23:13:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:13:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:13:13 INFO - Using real prefix '/tools/python27' 23:13:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:13:13 INFO - Installing distribute.............................................................................................................................................................................................done. 23:13:16 INFO - Installing pip.................done. 23:13:16 INFO - Return code: 0 23:13:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:13:16 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')]} 23:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:16 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')]} 23:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:16 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:16 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 23:13:16 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 23:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:16 INFO - 'HOME': '/Users/cltbld', 23:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:16 INFO - 'LOGNAME': 'cltbld', 23:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:16 INFO - 'MOZ_NO_REMOTE': '1', 23:13:16 INFO - 'NO_EM_RESTART': '1', 23:13:16 INFO - 'PAGER': '/bin/cat', 23:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:16 INFO - 'PWD': '/builds/slave/test', 23:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:16 INFO - 'SHELL': '/bin/bash', 23:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:16 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:16 INFO - 'USER': 'cltbld', 23:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:16 INFO - 'XPC_FLAGS': '0x0', 23:13:16 INFO - 'XPC_SERVICE_NAME': '0', 23:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:16 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 23:13:16 INFO - Cleaning up... 23:13:16 INFO - Return code: 0 23:13:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:13:16 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')]} 23:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:16 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')]} 23:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:16 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:16 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 23:13:16 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 23:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:16 INFO - 'HOME': '/Users/cltbld', 23:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:16 INFO - 'LOGNAME': 'cltbld', 23:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:16 INFO - 'MOZ_NO_REMOTE': '1', 23:13:16 INFO - 'NO_EM_RESTART': '1', 23:13:16 INFO - 'PAGER': '/bin/cat', 23:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:16 INFO - 'PWD': '/builds/slave/test', 23:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:16 INFO - 'SHELL': '/bin/bash', 23:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:16 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:16 INFO - 'USER': 'cltbld', 23:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:16 INFO - 'XPC_FLAGS': '0x0', 23:13:16 INFO - 'XPC_SERVICE_NAME': '0', 23:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:17 INFO - Downloading/unpacking psutil>=3.1.1 23:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:13:20 INFO - Installing collected packages: psutil 23:13:20 INFO - Running setup.py install for psutil 23:13:20 INFO - building 'psutil._psutil_osx' extension 23:13:20 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 23:13:20 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 23:13:20 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 23:13:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 23:13:21 INFO - building 'psutil._psutil_posix' extension 23:13:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 23:13:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:13:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:13:21 INFO - ^ 23:13:21 INFO - 1 warning generated. 23:13:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 23:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:13:21 INFO - Successfully installed psutil 23:13:21 INFO - Cleaning up... 23:13:21 INFO - Return code: 0 23:13:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:13:21 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')]} 23:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:21 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')]} 23:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:21 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:21 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 23:13:21 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 23:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:21 INFO - 'HOME': '/Users/cltbld', 23:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:21 INFO - 'LOGNAME': 'cltbld', 23:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:21 INFO - 'MOZ_NO_REMOTE': '1', 23:13:21 INFO - 'NO_EM_RESTART': '1', 23:13:21 INFO - 'PAGER': '/bin/cat', 23:13:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:21 INFO - 'PWD': '/builds/slave/test', 23:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:21 INFO - 'SHELL': '/bin/bash', 23:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:21 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:21 INFO - 'USER': 'cltbld', 23:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:21 INFO - 'XPC_FLAGS': '0x0', 23:13:21 INFO - 'XPC_SERVICE_NAME': '0', 23:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:13: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 23:13: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 23:13: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 23:13: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 23:13: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 23:13: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 23:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:13:24 INFO - Installing collected packages: mozsystemmonitor 23:13:24 INFO - Running setup.py install for mozsystemmonitor 23:13:24 INFO - Successfully installed mozsystemmonitor 23:13:24 INFO - Cleaning up... 23:13:24 INFO - Return code: 0 23:13:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:13: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')]} 23:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13: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')]} 23:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:24 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:24 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 23:13:24 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 23:13:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:24 INFO - 'HOME': '/Users/cltbld', 23:13:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:24 INFO - 'LOGNAME': 'cltbld', 23:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:24 INFO - 'MOZ_NO_REMOTE': '1', 23:13:24 INFO - 'NO_EM_RESTART': '1', 23:13:24 INFO - 'PAGER': '/bin/cat', 23:13:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:24 INFO - 'PWD': '/builds/slave/test', 23:13:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:24 INFO - 'SHELL': '/bin/bash', 23:13:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:24 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:24 INFO - 'USER': 'cltbld', 23:13:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:24 INFO - 'XPC_FLAGS': '0x0', 23:13:24 INFO - 'XPC_SERVICE_NAME': '0', 23:13:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:24 INFO - Downloading/unpacking jsonschema==2.5.1 23:13:24 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 23:13:24 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 23:13:24 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 23:13:24 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 23:13:24 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 23:13:24 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 23:13:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:13:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:13:27 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 23:13:27 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 23:13:27 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 23:13:27 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 23:13:27 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 23:13:27 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 23:13:27 INFO - Downloading functools32-3.2.3-2.tar.gz 23:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:13:27 INFO - warning: no files found matching '*.txt' 23:13:27 INFO - no previously-included directories found matching 'build' 23:13:27 INFO - no previously-included directories found matching 'dist' 23:13:27 INFO - no previously-included directories found matching '.git*' 23:13:27 INFO - Installing collected packages: jsonschema, functools32 23:13:27 INFO - Running setup.py install for functools32 23:13:27 INFO - warning: no files found matching '*.txt' 23:13:27 INFO - no previously-included directories found matching 'build' 23:13:27 INFO - no previously-included directories found matching 'dist' 23:13:27 INFO - no previously-included directories found matching '.git*' 23:13:28 INFO - Successfully installed jsonschema functools32 23:13:28 INFO - Cleaning up... 23:13:28 INFO - Return code: 0 23:13:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:28 INFO - 'HOME': '/Users/cltbld', 23:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:28 INFO - 'LOGNAME': 'cltbld', 23:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:28 INFO - 'MOZ_NO_REMOTE': '1', 23:13:28 INFO - 'NO_EM_RESTART': '1', 23:13:28 INFO - 'PAGER': '/bin/cat', 23:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:28 INFO - 'PWD': '/builds/slave/test', 23:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:28 INFO - 'SHELL': '/bin/bash', 23:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:28 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:28 INFO - 'USER': 'cltbld', 23:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:28 INFO - 'XPC_FLAGS': '0x0', 23:13:28 INFO - 'XPC_SERVICE_NAME': '0', 23:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:13:28 INFO - Cleaning up... 23:13:28 INFO - Return code: 0 23:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:28 INFO - 'HOME': '/Users/cltbld', 23:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:28 INFO - 'LOGNAME': 'cltbld', 23:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:28 INFO - 'MOZ_NO_REMOTE': '1', 23:13:28 INFO - 'NO_EM_RESTART': '1', 23:13:28 INFO - 'PAGER': '/bin/cat', 23:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:28 INFO - 'PWD': '/builds/slave/test', 23:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:28 INFO - 'SHELL': '/bin/bash', 23:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:28 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:28 INFO - 'USER': 'cltbld', 23:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:28 INFO - 'XPC_FLAGS': '0x0', 23:13:28 INFO - 'XPC_SERVICE_NAME': '0', 23:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:28 INFO - Downloading/unpacking blobuploader==1.2.4 23:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:31 INFO - Downloading blobuploader-1.2.4.tar.gz 23:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:13:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:13:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:32 INFO - Downloading docopt-0.6.1.tar.gz 23:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:13:32 INFO - Installing collected packages: blobuploader, requests, docopt 23:13:32 INFO - Running setup.py install for blobuploader 23:13:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:13:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:13:32 INFO - Running setup.py install for requests 23:13:33 INFO - Running setup.py install for docopt 23:13:33 INFO - Successfully installed blobuploader requests docopt 23:13:33 INFO - Cleaning up... 23:13:33 INFO - Return code: 0 23:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13: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')]} 23:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13: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')]} 23:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:33 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:33 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 23:13:33 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 23:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:33 INFO - 'HOME': '/Users/cltbld', 23:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:33 INFO - 'LOGNAME': 'cltbld', 23:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:33 INFO - 'MOZ_NO_REMOTE': '1', 23:13:33 INFO - 'NO_EM_RESTART': '1', 23:13:33 INFO - 'PAGER': '/bin/cat', 23:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:33 INFO - 'PWD': '/builds/slave/test', 23:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:33 INFO - 'SHELL': '/bin/bash', 23:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:33 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:33 INFO - 'USER': 'cltbld', 23:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:33 INFO - 'XPC_FLAGS': '0x0', 23:13:33 INFO - 'XPC_SERVICE_NAME': '0', 23:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:13:33 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-I8hwPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:13:33 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FGIe8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:13:33 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-EzvydF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:13:33 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-cBvZgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:13:33 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-rLPSpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-u_BM9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xS4gbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Hmplcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-IXZJwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-NMPPPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9qZ_u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-X2bKEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-DP4RvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:13:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-kOa26q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-uObO6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:13:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-PhDsMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:13:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FK_4ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:13:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:13:35 INFO - Running setup.py install for manifestparser 23:13:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:13:35 INFO - Running setup.py install for mozcrash 23:13:35 INFO - Running setup.py install for mozdebug 23:13:35 INFO - Running setup.py install for mozdevice 23:13:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:13:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:13:35 INFO - Running setup.py install for mozfile 23:13:36 INFO - Running setup.py install for mozhttpd 23:13:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Running setup.py install for mozinfo 23:13:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Running setup.py install for mozInstall 23:13:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Running setup.py install for mozleak 23:13:36 INFO - Running setup.py install for mozlog 23:13:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Running setup.py install for moznetwork 23:13:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:13:36 INFO - Running setup.py install for mozprocess 23:13:37 INFO - Running setup.py install for mozprofile 23:13:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:13:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:13:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:13:37 INFO - Running setup.py install for mozrunner 23:13:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:13:37 INFO - Running setup.py install for mozscreenshot 23:13:37 INFO - Running setup.py install for moztest 23:13:37 INFO - Running setup.py install for mozversion 23:13:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:13:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:13:37 INFO - Cleaning up... 23:13:37 INFO - Return code: 0 23:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:37 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:37 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 23:13:37 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 23:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:37 INFO - 'HOME': '/Users/cltbld', 23:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:37 INFO - 'LOGNAME': 'cltbld', 23:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:37 INFO - 'MOZ_NO_REMOTE': '1', 23:13:37 INFO - 'NO_EM_RESTART': '1', 23:13:37 INFO - 'PAGER': '/bin/cat', 23:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:37 INFO - 'PWD': '/builds/slave/test', 23:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:37 INFO - 'SHELL': '/bin/bash', 23:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:37 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:37 INFO - 'USER': 'cltbld', 23:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:37 INFO - 'XPC_FLAGS': '0x0', 23:13:37 INFO - 'XPC_SERVICE_NAME': '0', 23:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-iLlWP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:13:38 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)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-pPYI7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-2obszP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:13:38 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)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Au3uQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-dUKpUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:13:38 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)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-WymiuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:13:38 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)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-pjO0Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:13:38 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)) 23:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:13:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-JMhByB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-7_f5f5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-vitZ4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:13:39 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)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-1CuCqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:13:39 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)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-69vhcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ayswow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:13:39 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)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fd7W0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Z3oYi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:39 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)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Jsw1jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:13:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-PkRtA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:13:39 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)) 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:13:39 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)) 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:13:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:13:42 INFO - Downloading blessings-1.6.tar.gz 23:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:13:42 INFO - Installing collected packages: blessings 23:13:42 INFO - Running setup.py install for blessings 23:13:42 INFO - Successfully installed blessings 23:13:42 INFO - Cleaning up... 23:13:42 INFO - Return code: 0 23:13:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:13:43 INFO - Reading from file tmpfile_stdout 23:13:43 INFO - Current package versions: 23:13:43 INFO - blessings == 1.6 23:13:43 INFO - blobuploader == 1.2.4 23:13:43 INFO - docopt == 0.6.1 23:13:43 INFO - functools32 == 3.2.3-2 23:13:43 INFO - jsonschema == 2.5.1 23:13:43 INFO - manifestparser == 1.1 23:13:43 INFO - mozInstall == 1.12 23:13:43 INFO - mozcrash == 0.17 23:13:43 INFO - mozdebug == 0.1 23:13:43 INFO - mozdevice == 0.48 23:13:43 INFO - mozfile == 1.2 23:13:43 INFO - mozhttpd == 0.7 23:13:43 INFO - mozinfo == 0.9 23:13:43 INFO - mozleak == 0.1 23:13:43 INFO - mozlog == 3.4 23:13:43 INFO - moznetwork == 0.27 23:13:43 INFO - mozprocess == 0.23 23:13:43 INFO - mozprofile == 0.28 23:13:43 INFO - mozrunner == 6.12 23:13:43 INFO - mozscreenshot == 0.1 23:13:43 INFO - mozsystemmonitor == 0.3 23:13:43 INFO - moztest == 0.7 23:13:43 INFO - mozversion == 1.4 23:13:43 INFO - psutil == 3.1.1 23:13:43 INFO - requests == 1.2.3 23:13:43 INFO - wsgiref == 0.1.2 23:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:43 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 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:43 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 23:13:43 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 23:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:43 INFO - 'HOME': '/Users/cltbld', 23:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:43 INFO - 'LOGNAME': 'cltbld', 23:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:43 INFO - 'MOZ_NO_REMOTE': '1', 23:13:43 INFO - 'NO_EM_RESTART': '1', 23:13:43 INFO - 'PAGER': '/bin/cat', 23:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:43 INFO - 'PWD': '/builds/slave/test', 23:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:43 INFO - 'SHELL': '/bin/bash', 23:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:43 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:43 INFO - 'USER': 'cltbld', 23:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:43 INFO - 'XPC_FLAGS': '0x0', 23:13:43 INFO - 'XPC_SERVICE_NAME': '0', 23:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 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)) 23:13:43 INFO - Cleaning up... 23:13:43 INFO - Return code: 0 23:13:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e675490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5eb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd51b5883d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, '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.PxoaWNNpys/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.UxQNJcb8kY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 23:13:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:13:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:13:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:43 INFO - 'HOME': '/Users/cltbld', 23:13:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:43 INFO - 'LOGNAME': 'cltbld', 23:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:43 INFO - 'MOZ_NO_REMOTE': '1', 23:13:43 INFO - 'NO_EM_RESTART': '1', 23:13:43 INFO - 'PAGER': '/bin/cat', 23:13:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:43 INFO - 'PWD': '/builds/slave/test', 23:13:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:43 INFO - 'SHELL': '/bin/bash', 23:13:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:13:43 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:13:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:43 INFO - 'USER': 'cltbld', 23:13:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:43 INFO - 'XPC_FLAGS': '0x0', 23:13:43 INFO - 'XPC_SERVICE_NAME': '0', 23:13:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:13:43 INFO - Cleaning up... 23:13:43 INFO - Return code: 0 23:13:43 INFO - Running post-action listener: _resource_record_post_action 23:13:43 INFO - Running post-action listener: _start_resource_monitoring 23:13:43 INFO - Starting resource monitoring. 23:13:43 INFO - [mozharness: 2016-11-05 06:13:43.724872Z] Finished create-virtualenv step (success) 23:13:43 INFO - [mozharness: 2016-11-05 06:13:43.725812Z] Running install step. 23:13:43 INFO - Running pre-action listener: _resource_record_pre_action 23:13:43 INFO - Running main action method: install 23:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:13:43 INFO - Reading from file tmpfile_stdout 23:13:43 INFO - Detecting whether we're running mozinstall >=1.0... 23:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:13:44 INFO - Reading from file tmpfile_stdout 23:13:44 INFO - Output received: 23:13:44 INFO - Usage: mozinstall [options] installer 23:13:44 INFO - Options: 23:13:44 INFO - -h, --help show this help message and exit 23:13:44 INFO - -d DEST, --destination=DEST 23:13:44 INFO - Directory to install application into. [default: 23:13:44 INFO - "/builds/slave/test"] 23:13:44 INFO - --app=APP Application being installed. [default: firefox] 23:13:44 INFO - mkdir: /builds/slave/test/build/application 23:13:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 23:14:16 INFO - Reading from file tmpfile_stdout 23:14:16 INFO - Output received: 23:14:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 23:14:16 INFO - Running post-action listener: _resource_record_post_action 23:14:16 INFO - [mozharness: 2016-11-05 06:14:16.627553Z] Finished install step (success) 23:14:16 INFO - [mozharness: 2016-11-05 06:14:16.627700Z] Running run-tests step. 23:14:16 INFO - Running pre-action listener: _resource_record_pre_action 23:14:16 INFO - Running main action method: run_tests 23:14:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:14:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:14:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:14:16 INFO - 2016-11-04 23:14:16.642 screenresolution[1641:7691] starting screenresolution argv=screenresolution get 23:14:16 INFO - 2016-11-04 23:14:16.644 screenresolution[1641:7691] Display 0: 1600x1200x32@60 23:14:16 INFO - 2016-11-04 23:14:16.650 screenresolution[1642:7693] starting screenresolution argv=screenresolution list 23:14:16 INFO - Available Modes on Display 0 23:14:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:14:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:14:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:14:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:14:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:14:16 INFO - Intel Iris: 23:14:16 INFO - Chipset Model: Intel Iris 23:14:16 INFO - Type: GPU 23:14:16 INFO - Bus: Built-In 23:14:16 INFO - VRAM (Dynamic, Max): 1536 MB 23:14:16 INFO - Vendor: Intel (0x8086) 23:14:16 INFO - Device ID: 0x0a2e 23:14:16 INFO - Revision ID: 0x0009 23:14:16 INFO - Displays: 23:14:16 INFO - Display: 23:14:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:14:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:14:16 INFO - Display Serial Number: 1600x1200 60 23:14:16 INFO - Main Display: Yes 23:14:16 INFO - Mirror: Off 23:14:16 INFO - Online: Yes 23:14:16 INFO - Rotation: Supported 23:14:16 INFO - Return code: 0 23:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:14:16 INFO - Python 2.7.3 23:14:16 INFO - Return code: 0 23:14:16 INFO - grabbing minidump binary from tooltool 23:14:16 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')]} 23:14:16 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 0x10e489d30>, '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 0x10e2efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e481b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:14:16 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 23:14:16 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 23:14:16 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 23:14:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:14:17 INFO - Return code: 0 23:14:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:14:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:14:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:14:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:14:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 23:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --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 23:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PxoaWNNpys/Render', 23:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:14:17 INFO - 'HOME': '/Users/cltbld', 23:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:14:17 INFO - 'LOGNAME': 'cltbld', 23:14:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:14:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:17 INFO - 'MOZ_NO_REMOTE': '1', 23:14:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:14:17 INFO - 'NO_EM_RESTART': '1', 23:14:17 INFO - 'PAGER': '/bin/cat', 23:14:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:17 INFO - 'PWD': '/builds/slave/test', 23:14:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:14:17 INFO - 'SHELL': '/bin/bash', 23:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxQNJcb8kY/Listeners', 23:14:17 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 23:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:14:17 INFO - 'USER': 'cltbld', 23:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:17 INFO - 'XPC_FLAGS': '0x0', 23:14:17 INFO - 'XPC_SERVICE_NAME': '0', 23:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:14:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 23:14:17 INFO - mozversion application_buildid: 20161104212320 23:14:17 INFO - mozversion application_changeset: 69e17427242dc8063a7ad7d739247d4c47402da5 23:14:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:14:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:14:17 INFO - mozversion application_name: Firefox 23:14:17 INFO - mozversion application_remotingname: firefox-dev 23:14:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:14:17 INFO - mozversion application_vendor: Mozilla 23:14:17 INFO - mozversion application_version: 51.0a2 23:14:17 INFO - mozversion platform_buildid: 20161104212320 23:14:17 INFO - mozversion platform_changeset: 69e17427242dc8063a7ad7d739247d4c47402da5 23:14:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:14:17 INFO - mozversion platform_version: 51.0a2 23:14:17 INFO - using testdate: 1478326457 23:14:17 INFO - actual date: 1478326457 23:14:17 INFO - starting webserver on 'localhost:49277' 23:14:17 INFO - SUITE-START | Running 2 tests 23:14:17 INFO - TEST-START | dromaeo_css 23:14:17 INFO - operating with platform_type : mac_ 23:14:17 INFO - Initialising browser for dromaeo_css test... 23:14:17 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpMCPRN0/profile http://localhost:49277/getInfo.html) 23:14:19 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 23:14:19 INFO - PROCESS | 1652 | colorDepth:24 23:14:19 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 23:14:19 INFO - PROCESS | 1652 | __metrics 23:14:19 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:14:19 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:14:20 INFO - TEST-INFO | 1652: exit 0 23:14:20 INFO - Browser initialized. 23:14:20 INFO - Running cycle 1/1 for dromaeo_css test... 23:14:20 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpMCPRN0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:32 INFO - PROCESS | 1654 | RSS: Main: 220348416 23:14:32 INFO - PROCESS | 1654 | 23:15:24 INFO - PROCESS | 1654 | 1478326524376 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:17:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 23:17:37 INFO - PROCESS | 1654 | RSS: Main: 379187200 23:17:37 INFO - PROCESS | 1654 | 23:20:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 23:20:41 INFO - PROCESS | 1654 | RSS: Main: 351248384 23:20:41 INFO - PROCESS | 1654 | 23:23:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 23:23:44 INFO - PROCESS | 1654 | RSS: Main: 322908160 23:23:44 INFO - PROCESS | 1654 | 23:26:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 23:26:47 INFO - PROCESS | 1654 | RSS: Main: 320942080 23:26:47 INFO - PROCESS | 1654 | 23:29:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 23:29:51 INFO - PROCESS | 1654 | RSS: Main: 313589760 23:29:51 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 23:32:54 INFO - PROCESS | 1654 | RSS: Main: 437989376 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | __start_tp_report 23:32:54 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 23:32:54 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 23:32:54 INFO - PROCESS | 1654 | |i|pagename|runs| 23:32:54 INFO - PROCESS | 1654 | |0;dojo.html;3306.3717893600215;3333.949990750139;3361.2437201629623;3370.7528214560616;3400.8979730608075;5683.914741278879;5725.370209276986;5761.1358296255585;5773.797917072903;5789.24739783828;5662.745176467059;5754.712264386774;5764.884702305952;5773.422657734224;5783.508401785843;4775.617950563964;5188.066148093332;5232.973835130819;5251.975864706384;5297.284866543006;4990.226514890198;5168.715720635363;5171.198464238049;5211.192265198882;5241.161414173733;5202.817901373433;5227.973860130713;5316.707581083039;5326.2543243945875;5348.411674715778;4149;5237.607179461536;5301.681899086028;5308.681479111266;5353.892922141575;5014.824481143179;5106.795728170869;5255.001549705544;5258.079836028718;5303.363596368422;5586.748596313176;5631.549476041907;5659.320881494247;5665.49010589049;5674.858128546778;6110.406879924458;6143.801958618072;6175.629462232236;6176.320604733476;6181.412765787288;6224.408681175281;6230.87538249237;6232.252129744415;6236.87526249477;6239.594426362317;5743.253377061039;5818.301803783488;5821.854453638693;5920.881582368328;5937.495312898409;6244.968775156095;6269.686515674198;6272.5922815016875;6273.560850740496;6302.716377763011;6164.4143806339225;6165.167702360213;6187.628742275478;6192.380761923771;6192.97815860387;6104.298745950694;6124.5100391968535;6139.001538246403;6204.565680402328;6209.285932117774;6124.289394097934;6165.599236049642;6166.568340216142;6234.906476402857;6253.374662533801;6257.405546473078;6264.404881536247;6269.529785266032;6277.497800175975;6313.96843015782;4830.637702172351;4833.951660483421;4906.95093049065;4922.384701912261;4925.75371231437;4391.802368893407;4445.1998640245065;4461.063176732922;4466.888327791831;4506.7070640408265;5784.768609255667;5784.797532086357;5796.82609521715;5810.709464526757;5819.621724587888;6305.464035557029;6310.148130002391;6315.021171718391;6322.525810564226;6333.619982800955;5706.828795136153;5760.42395760429;5779.739911703983;5801.187833703285;5823.88352232953;5410.945890541123;5447.6731396115565;5465.9180112298345;5467.863303417367;5491.121420572769;5283.260343551906;5746.678263999303;6295.874082518324;6312.779052733133;6320.08358787964;6062.636241825505;6173.84565385869;6198.380161983946;6346.841328966812;6370.745170193326;6250.3749625037135;6286.057091436322;6294.905576416449;6306;6330.208723909512;6225.8132256032395;6228.34602366745;6231.439170474498;6241.469475094668;6245.094461303176;6148.692565371803;6282.623042617458;6286.5599408041;6316.810495685137;6321.494280457644;6068.362821903813;6115.785947491817;6127.158986117617;6132.20254427538;6221.564490485623;6184.690765461799;6184.8763024738355;6185.474234690102;6192.256929168529;6204.751809927733;6022.608530445507;6049.667268300285;6056.394360564084;6066.787662431793;6158.907616385668;5979.611325263844;5998.520118390431;6005.249343832021;6082.695865206811;6091.147239386578;5748.885022299614;5927.762889484372;5933.495652869382;5942.702864856654;5972.343042265435 23:32:54 INFO - PROCESS | 1654 | |1;ext.html;463.96998662968207;470.87286432663205;495.49212057640926;536.554659632505;542.8751387180948;23617.645735313985;38897.02757431062;39939;40142.992850357514;40152;41000.38499422511;41437.58562414375;41520.79239603805;41647;41780.58219417805;8115.75652730419;9736.853947190797;9755.268354873377;9759.926408095103;9773.804523909517;8598.269147122503;8809.691660791874;11828.408579570987;12097.697557561043;12111.939440302785;11940.880591194107;12045.819312710317;12064;12071.155019148664;12074.396280186;11875.16873818833;11967.461464234044;11979.700507487383;11983.041356691443;11992.100592455601;11703.88296117045;11782.057435405148;11800.40997950099;11809.173357864953;11810.40947952599;39017.82946511609;39227.60772392296;39227.8038609808;39235.01912452183;39253;2709.9322516937036;3344.2308269098244;3440.535527703753;3602.35157671619;3664.926701465956;29024.41951160965;30045.849770751225;30215.244618884703;30467.847660761556;30700.2324941876;3109.9844500777576;3147.5750773645723;3175.6348019977536;3222.871085156591;3280.950785738216;490279.54860225826;491473.8836752355;493529.5323523359;493867;494708;33167.83912563097;33449.83275083609;33826.32347353089;54985.725071375186;55426.891462171334;34906.65093349085;34936.475952860725;35001.474977875354;35101.824490877385;35167.296654067286;14445.855541444662;14494.637634059021;14593.92703036478;14595.92702036483;14665.120092794466;11041.668749937515;11311.660650180507;12280;12429.689257768447;12431.31627760482;7275.927240727631;7504.212057733968;7681.116671582728;7694.0767107946285;7694.192109828499;2906.215321863085;3167.7329068372374;3246.5130230465147;3256.348730253959;3278.7213086887405;902.6434558349547;971.4122955611895;992.4591097851688;1080.5191689698165;1132.3375825142384;29525;29847.850760746056;30092;30290.69709302923;30308.696913031028;1045.278757657214;1112.2158877990996;1128.3230061962756;1145.6906635208447;1153.7923173828792;13032.41354139066;15311.770323445156;15328.707632406618;15374.923125384525;15617.765733514007;205057;206851;207591.96204018884;207596.96201518897;208019;55826.72086639622;56078.43921560814;56108.719456402454;56137.71931140318;56241.15638265429;1220.6582156995878;1248.1263115818963;1344.515974249289;1355.8101865738804;1366.3782978744846;25684;30036.699633004264;30416.847915760278;30657.386852262385;31050.534241985937;46697.53302466932;47166;47231;47290.52709472999;47406.28890566575;465759;466318;467843;468526;680099;39810.40284395794;40388;40441;40505.392419113145;40776.59223407728;44503.55496444994;44602.55397445984;44955.77522112369;45010.32484512669;45336.77331613321;32030.839845800623;36516;37205.255894882495;39645.00887477836;41011.38482922699;37525.81237093797;37646.43530346992;38421.807890961485;38492.42261366026;39612.60387396089;36627.45058824173;36955.07612309714;37400.812995934844;37632.43551346677;37700;32399.838000809847;33566.832165839995;34049.65950340564;34312.485312720826;34415;25328.986840526173;25382.111626093;25579;25628.103016394336;25705.485890282464 23:32:54 INFO - PROCESS | 1654 | |2;jquery.html;346.1899155975018;368.5724559510968;372.6162053085323;379.2301627695779;396.3974758367282;15032.022918510303;15133.697326053472;16230.350785968547;20771.376858694224;21216.15135394586;19177.52056198596;19839.702404463907;20325.186992520317;20565.485862853435;20910;5140.203268493371;5857.209276747627;6120.449159575637;6123;6123.877522449548;5974;6020.969895150518;6081.391860813927;6083.847903802396;6089.360617135181;4945.307656928033;5194.168932970725;5764.7982320618785;5865.736041878125;6042.425969532887;5946.940530594704;5981.491573216282;5985.880282394328;5986.730597123096;5988.101784732282;5034.169362055257;5160.664556803796;5175.987543513415;5227.2159176123505;5231.659942103751;26406;26489.337766555796;26560.86719566409;26755.190704976085;26868.328291792666;2074.3258441006583;2213.1479380438486;2434.221049264236;2459.225344016629;2997.865096070682;10367.48162591875;10396.376217426978;11225.438728063564;15161.241937903062;15184.164870932094;1741.9651606967916;1810.5021119192327;1837.8162183781649;1876.6434377468238;1928.633559623681;106840.39739403916;115230.42384788023;119171;122447.16329255157;124886.37556812249;9143.725688229364;11371.431428428545;11580.247283926517;11639.243449175945;11822.527098915947;11897.821532677017;14471.638209044859;14510;14547.709045819236;14567.344469498898;8222.547759873265;8423.410361274775;8465.873011904827;8568.742937711879;8578.670306102564;8161;8330.166983301622;8343.666253349798;8446.535440550706;8491.278241349555;4456.888577785581;4507.504174540798;4530.45964372115;4556.430446194226;4624.28323609841;1846.270723064382;1897.6679081160742;1901.657701613695;1902.7811801642988;1909.465349702058;838.5597561280376;865.1175800683268;909.9863502047475;927.5084205371164;1044.2324891204958;20838.895805520875;21518.46203844885;21559.137634494757;21698;21770.891145544487;946.8437707778277;948.6158105966956;955.1594596754811;960.9759756006016;1001.5993602558889;10849.945750271198;11327.300904864336;11438.542458301741;11535.96176344133;11572.942135289439;545279;571131;601582;630012;637232;81123;126309.31608077475;127408;129408;135460.32269838784;946.5314669238771;994.7314225159312;1024.1806554756165;1024.5184763161303;1026.235454586338;16483.258253378866;17904.820951790316;19371.3220037298;20316.390508284774;20376.98115094269;58082.4191758077;58712.412875870694;59484.70257648857;60132.39867601268;60325;69797.65101174462;72576.63711681408;81895.590522047;82313;83086.16913830784;7552.234040430236;7893.210678932061;8137.389695772722;8286.337093032422;8454.91545084566;12005.339706316236;12984.805227921399;13191.142575732547;13504.864951350753;13620.93189534046;11273.323600583662;11422.97193252578;11430.1998860079;11751.823722644338;11763.882431169026;9949.751256218653;10775.6228532001;11139.10887129044;11534.120163174872;11663.533458661559;11435.771284574428;11466.2546934449;11601.419929003685;11805.23265987708;11972.341521216416;7900.68397264103;7929.801754956172;8064.556449395105;8125.228103330174;8198.221168988937;8682.262007729161;9316.394434361744;11357.716057098638;11605.361705106301;11675.416229188677 23:32:54 INFO - PROCESS | 1654 | |3;mootools.html;1341.5908148014855;1541.437375357994;1573.6773961337926;1699.8045224799143;1879.0322983663407;8138.145494723058;8390.328773698106;8598.398112132154;9164.175224229817;9175.678851240216;7360.411167106632;7813.843723125534;8246.46397984132;8814.4711317321;8903.554822258877;2372.608519594269;2411.4212588978694;2417.2506522977847;2417.5406672732124;2417.625268083441;2120.0777661717125;2364.988175059122;2385.141349114326;2442.4016116051594;2450.644656524803;2167.837412194092;2197.099189332374;2361.645753137026;2426.235735743235;2433.8174636902304;2376.144587948337;2380.8690522021284;2383.809295256375;2390.414348484615;2391.0794344177443;2407.735149133594;2412.360724408033;2413.251891913495;2415.215055107097;2420.8426452280546;8931.062238464932;9003.234725048378;9069.773255668595;9081.68214112503;9085.727428177166;5260.316158899357;5403.432639572867;5464.207689884945;5464.781408743645;5465.207544905967;3457.2048428861503;3526.6825985661158;3652.7990960497164;3654.524911761481;3655.5430571178604;1041.9791604167874;1070.0850772589401;1072.7103682005816;1089.1559041742712;1091.2743025887776;11965.700857478545;12080.335581543011;12083.154179207459;12108.636740897788;12132;4693.48371679115;4766.293614219895;4794.664373493822;4899.657024008286;4928.112939670822;10011.699649010541;10263.435511046964;10266.332688375232;10271.332363396356;10275.972402759664;5442.9930462864495;5459.1265397537;5461.180822876521;5468.671879687232;5469.535089517356;4931.334269873521;4936.086823937583;4941.43173535048;4971.825986090469;5004.674696144739;3333.333333333343;3994.3409337458993;4035.334169861999;4056.9797151014054;4108.36320370343;1079.5897558927713;1176.8757392905716;1272.7899896516972;1277.9552715654906;1293.9417726202344;784.9450538462366;885.2298500304776;888.4092078767547;912.4753266871576;952.1782810311613;5823.650580965155;5854.8536286592325;5883;5917.260342457193;6086.330503644595;815.7756616930272;937.0488953711988;942.3780304998668;976.8778902637171;1031.118393773313;3392.6268110507826;3608.657177568127;3680.4663323817895;3698.4452332150395;3729.384651532521;10766.676999690022;10952.123830093573;11027.0075693188;11085.944570277097;11137.387443690675;10879.728006799893;10887.292325998786;10894.509747061402;10897.019268265894;10990.725231869268;8007.359411247086;8244.711435099744;8401.327893768485;8419;8427.325813934993;5884.382139875252;5949.1076338549565;6038.939610604013;6051.001584738468;6052.878942421215;10177;10215.02957219063;10227;10346.120579750805;10353.223508237063;10019.448930308903;10172.08451239392;10534.42060686639;10548.578056877639;10555.841662374916;7365.8158546036775;7507.962460187664;7520.736774212876;7522.322990930843;7524.360429363565;7978.561179135203;8065.274125328749;8142.959285203536;8143.104258531438;8165.469244499089;7112.039874617068;7421.257874212535;7524.322810947041;7533.472656913963;7560.810979725331;7301.561906285639;7390.852182956418;7404.888926666212;7413.629318534159;7444.292792184734;6796.76211332601;6797.286284940208;6914.274001229798;6919.65066811987;6948.270431604608;4835.347228124158;4842.128416884994;4991.4061875449615;4991.675541089818;5132.281480592795;4938.975305123451;4995.725235112103;5068;5108.770105345194;5114.258432527188 23:32:54 INFO - PROCESS | 1654 | |4;prototype.html;300.25386913519907;303.3145092091872;308.91968088297034;313.84464689978466;315.6922001048979;4483.439570053743;5007.324011258479;5071.315372424726;5234.717494213918;5461.262729531517;4186.958130418695;5050.6969581825115;5109.897802043957;5208.5572726318305;5210.635255532115;3782.829772660223;3798.0504873781556;4124.443200167984;4147.129102888382;4156.937645935313;4121.5466298707115;4138.4413104231;4151.356539736331;4160.689382844409;4217.15656868626;3468.514407982884;3813.0344441780517;4099.483147060119;4153.646940010103;4159.875203743893;4089.9795501022304;4122.42286079949;4127.938080928789;4130.80206740045;4132.8966775830695;3293.5059741039036;3342.2145795737983;3598.24436868258;3598.748087633867;3599.586047604507;4614.723116613014;4957.702537847741;5292.285541451894;5321.946780532184;5325.360956685184;3736.9439458408146;3966.8099570128848;4359.975405779639;4725.881852953669;4784.976075119637;4869.70781753096;5666.235058267122;5736.6558006519745;5772.913406298909;5782.306123265193;3469.3061387722555;3969.3527186217684;3990.7628635123206;4005.5794141615;4031.475908131924;4936.456989731127;5664.20701101846;5720.456556627156;5896.675682837442;6034.818955431344;3335;4001.619846114673;4013.3979903014197;4060.614241647098;4105;3933.3903244997073;4101.5488296287385;4133.607307305801;4147.6474499667265;4167.333226683716;4264.509581398117;4559.974005848658;4645.790939407667;4766.404199475066;4820.807167713322;5166.3025491558155;5682.783714351406;5683.2895888014;5685.508448325776;5689.601727879091;1326.396489597231;1369.383777300199;1412.5338638249352;1412.5974097382198;1416.9574912752635;811.4157806379397;869.8825658536017;937.1378331934636;945.6241169098945;970.3304719743354;4677.18149323867;4742.359781429532;4868.367112275381;5247.527722504993;5256.842294731087;5898.8230353089475;5906.734196961147;5934.673592952343;5969.970150149222;6009.759609615654;4773.689710168828;4843.297721830315;5163.683260768556;5385.2841539338515;5562.3881373048935;2574.5365834149657;2662.1348061879967;3122.297483066292;3131.5459258407404;3142.340108577179;5487.9420217418465;5510.752016159283;5792.94207057924;6071.785642871355;6089.995150800157;4593.770311484413;5169.508896654812;5933.436323549256;5982.713716550962;6101.84745381369;5277.815276465305;6118.632882027093;6163.753449862045;6189.938100619026;6296.087067375205;5705.4009329019855;5930;5975.922399964109;5982.46157845796;6031.668258245839;5873.911891321548;5874.353821079763;5910.586258962004;5916;5921.259842519685;5175.430702622633;5307.77953961932;6064.666443345658;6135.53983451234;6264.68676566179;3505.1237190702323;3912.9043867717087;3943.5859234779937;3962.5244970603712;3988.3818008208773;5996.72124592652;6022.789202377896;6058.697065146637;6068.4841788448475;6069.177832307998;5372.946270537244;5577.581681373832;5841.860837136717;5853.560982926212;5900.64596124234;5763.337216220189;5769.394213607511;5775.48020678141;5778;5817.650940943557;5229.450907654794;5265.921011184912;5450.31871016123;5648.83053508379;5720.313562372542;4798.640101992434;4958.801647934187;5000.624828172136;5681.289838770153;5781.971090144522;5052.520010598987;5196.636235463632;5631.577631677558;5682.971585142213;5712.714364281853 23:32:54 INFO - PROCESS | 1654 | |5;yui.html;672.8149758816322;708.5288283291611;722.9060222171117;745.7017193122751;748.7042618165826;14059.086159399632;15080.849191508081;15110.924445377757;15132.394704211833;15140.84859151408;13214.603561893158;13323.933380333085;13342;13346.399412026458;13350.332483375816;667.7362441835472;686.1834417043702;690.6167077272112;821.5194111444782;844.9408541402104;836.573347592726;852.0201767966826;852.7356519478982;853.5305581929945;854.3165467625905;811.2941740685612;893.1291990309429;903.7243640689587;904.6471875968377;908.9091090890892;702.3012102957539;721.6932803558519;862.0732712334266;905.5879574793453;906.7461110888962;661.0909998751716;665.5607299182516;666.3070406776947;666.3170250493283;666.8166254280063;14151.150930944177;14174.07868488545;14181.78727319091;14189.43242270308;14218.50235241772;11033.668989930315;12813.23120612757;12826.23042617446;12852.485900563966;12985;11774.116941229357;11959.820602690967;12011.399638911982;12301.569445069379;12346.876531234662;4144.585541445861;4330.5946830919165;4380.386745855582;4469.709468884512;4471.23988921884;119683.40158299153;120000.3999880005;120663.99999999913;122104.54118477365;125709.37145314306;9969.35199212049;9988.101070903653;10536.262461627612;10554.894451055545;10586;20117.798822011886;20118.59762804736;20127.993600319925;20144.496387590134;20146.19415223404;6080.939190608037;6908.6545672716165;7153.213146553875;7425.702971881173;7448.255174482617;3203.9266845606517;3916.686665066788;3980.3631418972827;4086.59134086589;4108.157827645326;3143.795653282575;3278.164068162651;3283.2120291130436;3295.9340813183603;3303;616.8673735146965;618.6985552151264;620.3703241210176;623.2147494157394;632.7279269913981;581.8516278348994;590.2887021139517;591.8106206014035;594.7502049139372;611.6635850282327;7836.960815196002;8736.388452808369;8785.956070219736;8799.648014079494;9037.954810226038;562.3869981719945;597.8087012156068;599.7331187621467;613.187526527353;629.6242709679365;4125.690573207022;4254.127903779779;4273.55127711592;4285.678574106954;4381.9342709859375;98454;128968.71031289754;131570.34214828865;133814;141397;84258.15741842626;121856;123121.76878231282;124742;135281;101279.49360253151;101786.98213017923;103996;110682.78634427267;111127.88872111498;9335.486548239913;9763.463009534544;9831.311808173645;9977.45124018157;10003.549840257061;59106.70446647739;60317.69841150766;61747;63284.75950476601;64363.35636643761;86477.56761216154;87757.56121219353;92932.53533732289;94741;100471.49764251131;12442.129050966345;12620;12698.238105713686;13087.738245234852;13322.733545329233;14588.051776634486;14746.162810386268;14801.925990369979;14848.886333524813;15131.092134471966;13325.53360632412;13348.599542013755;13617.387217575035;13636.727265454834;13731.313434328444;11555.133364997491;12979.221246725227;13678.384472698952;13925.303734813016;14161;12397.256164630151;12701.22182894414;13936.860631393962;14158.858411415755;14161.716765664834;10968;11331.830022549833;11794.142226113214;11829.881701182878;12113.212641178296;11522.251053681484;11543.88456115428;11754.353510557;11791.88208117908;11826.467808948446 23:32:54 INFO - PROCESS | 1654 | __end_tp_report 23:32:54 INFO - PROCESS | 1654 | __start_cc_report 23:32:54 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1579 23:32:54 INFO - PROCESS | 1654 | __end_cc_report 23:32:54 INFO - PROCESS | 1654 | __startTimestamp1478327574527__endTimestamp 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | ------- Summary: start ------- 23:32:54 INFO - PROCESS | 1654 | Number of tests: 6 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5748.26 Median:5979.61 stddev:651.83 (10.9%) stddev-sans-first:625.05 23:32:54 INFO - PROCESS | 1654 | Values: 3306.4 3333.9 3361.2 3370.8 3400.9 5683.9 5725.4 5761.1 5773.8 5789.2 5662.7 5754.7 5764.9 5773.4 5783.5 4775.6 5188.1 5233.0 5252.0 5297.3 4990.2 5168.7 5171.2 5211.2 5241.2 5202.8 5228.0 5316.7 5326.3 5348.4 4149.0 5237.6 5301.7 5308.7 5353.9 5014.8 5106.8 5255.0 5258.1 5303.4 5586.7 5631.5 5659.3 5665.5 5674.9 6110.4 6143.8 6175.6 6176.3 6181.4 6224.4 6230.9 6232.3 6236.9 6239.6 5743.3 5818.3 5821.9 5920.9 5937.5 6245.0 6269.7 6272.6 6273.6 6302.7 6164.4 6165.2 6187.6 6192.4 6193.0 6104.3 6124.5 6139.0 6204.6 6209.3 6124.3 6165.6 6166.6 6234.9 6253.4 6257.4 6264.4 6269.5 6277.5 6314.0 4830.6 4834.0 4907.0 4922.4 4925.8 4391.8 4445.2 4461.1 4466.9 4506.7 5784.8 5784.8 5796.8 5810.7 5819.6 6305.5 6310.1 6315.0 6322.5 6333.6 5706.8 5760.4 5779.7 5801.2 5823.9 5410.9 5447.7 5465.9 5467.9 5491.1 5283.3 5746.7 6295.9 6312.8 6320.1 6062.6 6173.8 6198.4 6346.8 6370.7 6250.4 6286.1 6294.9 6306.0 6330.2 6225.8 6228.3 6231.4 6241.5 6245.1 6148.7 6282.6 6286.6 6316.8 6321.5 6068.4 6115.8 6127.2 6132.2 6221.6 6184.7 6184.9 6185.5 6192.3 6204.8 6022.6 6049.7 6056.4 6066.8 6158.9 5979.6 5998.5 6005.2 6082.7 6091.1 5748.9 5927.8 5933.5 5942.7 5972.3 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:54798.95 Median:18876.51 stddev:114756.11 (607.9%) stddev-sans-first:115005.52 23:32:54 INFO - PROCESS | 1654 | Values: 464.0 470.9 495.5 536.6 542.9 23617.6 38897.0 39939.0 40143.0 40152.0 41000.4 41437.6 41520.8 41647.0 41780.6 8115.8 9736.9 9755.3 9759.9 9773.8 8598.3 8809.7 11828.4 12097.7 12111.9 11940.9 12045.8 12064.0 12071.2 12074.4 11875.2 11967.5 11979.7 11983.0 11992.1 11703.9 11782.1 11800.4 11809.2 11810.4 39017.8 39227.6 39227.8 39235.0 39253.0 2709.9 3344.2 3440.5 3602.4 3664.9 29024.4 30045.8 30215.2 30467.8 30700.2 3110.0 3147.6 3175.6 3222.9 3281.0 490279.5 491473.9 493529.5 493867.0 494708.0 33167.8 33449.8 33826.3 54985.7 55426.9 34906.7 34936.5 35001.5 35101.8 35167.3 14445.9 14494.6 14593.9 14595.9 14665.1 11041.7 11311.7 12280.0 12429.7 12431.3 7275.9 7504.2 7681.1 7694.1 7694.2 2906.2 3167.7 3246.5 3256.3 3278.7 902.6 971.4 992.5 1080.5 1132.3 29525.0 29847.9 30092.0 30290.7 30308.7 1045.3 1112.2 1128.3 1145.7 1153.8 13032.4 15311.8 15328.7 15374.9 15617.8 205057.0 206851.0 207592.0 207597.0 208019.0 55826.7 56078.4 56108.7 56137.7 56241.2 1220.7 1248.1 1344.5 1355.8 1366.4 25684.0 30036.7 30416.8 30657.4 31050.5 46697.5 47166.0 47231.0 47290.5 47406.3 465759.0 466318.0 467843.0 468526.0 680099.0 39810.4 40388.0 40441.0 40505.4 40776.6 44503.6 44602.6 44955.8 45010.3 45336.8 32030.8 36516.0 37205.3 39645.0 41011.4 37525.8 37646.4 38421.8 38492.4 39612.6 36627.5 36955.1 37400.8 37632.4 37700.0 32399.8 33566.8 34049.7 34312.5 34415.0 25329.0 25382.1 25579.0 25628.1 25705.5 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:34972.73 Median:26525.10 stddev:99714.54 (375.9%) stddev-sans-first:99960.37 23:32:54 INFO - PROCESS | 1654 | Values: 346.2 368.6 372.6 379.2 396.4 15032.0 15133.7 16230.4 20771.4 21216.2 19177.5 19839.7 20325.2 20565.5 20910.0 5140.2 5857.2 6120.4 6123.0 6123.9 5974.0 6021.0 6081.4 6083.8 6089.4 4945.3 5194.2 5764.8 5865.7 6042.4 5946.9 5981.5 5985.9 5986.7 5988.1 5034.2 5160.7 5176.0 5227.2 5231.7 26406.0 26489.3 26560.9 26755.2 26868.3 2074.3 2213.1 2434.2 2459.2 2997.9 10367.5 10396.4 11225.4 15161.2 15184.2 1742.0 1810.5 1837.8 1876.6 1928.6 106840.4 115230.4 119171.0 122447.2 124886.4 9143.7 11371.4 11580.2 11639.2 11822.5 11897.8 14471.6 14510.0 14547.7 14567.3 8222.5 8423.4 8465.9 8568.7 8578.7 8161.0 8330.2 8343.7 8446.5 8491.3 4456.9 4507.5 4530.5 4556.4 4624.3 1846.3 1897.7 1901.7 1902.8 1909.5 838.6 865.1 910.0 927.5 1044.2 20838.9 21518.5 21559.1 21698.0 21770.9 946.8 948.6 955.2 961.0 1001.6 10849.9 11327.3 11438.5 11536.0 11572.9 545279.0 571131.0 601582.0 630012.0 637232.0 81123.0 126309.3 127408.0 129408.0 135460.3 946.5 994.7 1024.2 1024.5 1026.2 16483.3 17904.8 19371.3 20316.4 20377.0 58082.4 58712.4 59484.7 60132.4 60325.0 69797.7 72576.6 81895.6 82313.0 83086.2 7552.2 7893.2 8137.4 8286.3 8454.9 12005.3 12984.8 13191.1 13504.9 13620.9 11273.3 11423.0 11430.2 11751.8 11763.9 9949.8 10775.6 11139.1 11534.1 11663.5 11435.8 11466.3 11601.4 11805.2 11972.3 7900.7 7929.8 8064.6 8125.2 8198.2 8682.3 9316.4 11357.7 11605.4 11675.4 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5767.78 Median:4870.89 stddev:3270.32 (67.1%) stddev-sans-first:3262.58 23:32:54 INFO - PROCESS | 1654 | Values: 1341.6 1541.4 1573.7 1699.8 1879.0 8138.1 8390.3 8598.4 9164.2 9175.7 7360.4 7813.8 8246.5 8814.5 8903.6 2372.6 2411.4 2417.3 2417.5 2417.6 2120.1 2365.0 2385.1 2442.4 2450.6 2167.8 2197.1 2361.6 2426.2 2433.8 2376.1 2380.9 2383.8 2390.4 2391.1 2407.7 2412.4 2413.3 2415.2 2420.8 8931.1 9003.2 9069.8 9081.7 9085.7 5260.3 5403.4 5464.2 5464.8 5465.2 3457.2 3526.7 3652.8 3654.5 3655.5 1042.0 1070.1 1072.7 1089.2 1091.3 11965.7 12080.3 12083.2 12108.6 12132.0 4693.5 4766.3 4794.7 4899.7 4928.1 10011.7 10263.4 10266.3 10271.3 10276.0 5443.0 5459.1 5461.2 5468.7 5469.5 4931.3 4936.1 4941.4 4971.8 5004.7 3333.3 3994.3 4035.3 4057.0 4108.4 1079.6 1176.9 1272.8 1278.0 1293.9 784.9 885.2 888.4 912.5 952.2 5823.7 5854.9 5883.0 5917.3 6086.3 815.8 937.0 942.4 976.9 1031.1 3392.6 3608.7 3680.5 3698.4 3729.4 10766.7 10952.1 11027.0 11085.9 11137.4 10879.7 10887.3 10894.5 10897.0 10990.7 8007.4 8244.7 8401.3 8419.0 8427.3 5884.4 5949.1 6038.9 6051.0 6052.9 10177.0 10215.0 10227.0 10346.1 10353.2 10019.4 10172.1 10534.4 10548.6 10555.8 7365.8 7508.0 7520.7 7522.3 7524.4 7978.6 8065.3 8143.0 8143.1 8165.5 7112.0 7421.3 7524.3 7533.5 7560.8 7301.6 7390.9 7404.9 7413.6 7444.3 6796.8 6797.3 6914.3 6919.7 6948.3 4835.3 4842.1 4991.4 4991.7 5132.3 4939.0 4995.7 5068.0 5108.8 5114.3 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4626.01 Median:5164.99 stddev:1433.01 (27.7%) stddev-sans-first:1399.76 23:32:54 INFO - PROCESS | 1654 | Values: 300.3 303.3 308.9 313.8 315.7 4483.4 5007.3 5071.3 5234.7 5461.3 4187.0 5050.7 5109.9 5208.6 5210.6 3782.8 3798.1 4124.4 4147.1 4156.9 4121.5 4138.4 4151.4 4160.7 4217.2 3468.5 3813.0 4099.5 4153.6 4159.9 4090.0 4122.4 4127.9 4130.8 4132.9 3293.5 3342.2 3598.2 3598.7 3599.6 4614.7 4957.7 5292.3 5321.9 5325.4 3736.9 3966.8 4360.0 4725.9 4785.0 4869.7 5666.2 5736.7 5772.9 5782.3 3469.3 3969.4 3990.8 4005.6 4031.5 4936.5 5664.2 5720.5 5896.7 6034.8 3335.0 4001.6 4013.4 4060.6 4105.0 3933.4 4101.5 4133.6 4147.6 4167.3 4264.5 4560.0 4645.8 4766.4 4820.8 5166.3 5682.8 5683.3 5685.5 5689.6 1326.4 1369.4 1412.5 1412.6 1417.0 811.4 869.9 937.1 945.6 970.3 4677.2 4742.4 4868.4 5247.5 5256.8 5898.8 5906.7 5934.7 5970.0 6009.8 4773.7 4843.3 5163.7 5385.3 5562.4 2574.5 2662.1 3122.3 3131.5 3142.3 5487.9 5510.8 5792.9 6071.8 6090.0 4593.8 5169.5 5933.4 5982.7 6101.8 5277.8 6118.6 6163.8 6189.9 6296.1 5705.4 5930.0 5975.9 5982.5 6031.7 5873.9 5874.4 5910.6 5916.0 5921.3 5175.4 5307.8 6064.7 6135.5 6264.7 3505.1 3912.9 3943.6 3962.5 3988.4 5996.7 6022.8 6058.7 6068.5 6069.2 5372.9 5577.6 5841.9 5853.6 5900.6 5763.3 5769.4 5775.5 5778.0 5817.7 5229.5 5265.9 5450.3 5648.8 5720.3 4798.6 4958.8 5000.6 5681.3 5782.0 5052.5 5196.6 5631.6 5683.0 5712.7 23:32:54 INFO - PROCESS | 1654 | 23:32:54 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:23962.88 Median:3280.69 stddev:37792.39 (1152.0%) stddev-sans-first:37857.95 23:32:54 INFO - PROCESS | 1654 | Values: 672.8 708.5 722.9 745.7 748.7 14059.1 15080.8 15110.9 15132.4 15140.8 13214.6 13323.9 13342.0 13346.4 13350.3 667.7 686.2 690.6 821.5 844.9 836.6 852.0 852.7 853.5 854.3 811.3 893.1 903.7 904.6 908.9 702.3 721.7 862.1 905.6 906.7 661.1 665.6 666.3 666.3 666.8 14151.2 14174.1 14181.8 14189.4 14218.5 11033.7 12813.2 12826.2 12852.5 12985.0 11774.1 11959.8 12011.4 12301.6 12346.9 4144.6 4330.6 4380.4 4469.7 4471.2 119683.4 120000.4 120664.0 122104.5 125709.4 9969.4 9988.1 10536.3 10554.9 10586.0 20117.8 20118.6 20128.0 20144.5 20146.2 6080.9 6908.7 7153.2 7425.7 7448.3 3203.9 3916.7 3980.4 4086.6 4108.2 3143.8 3278.2 3283.2 3295.9 3303.0 616.9 618.7 620.4 623.2 632.7 581.9 590.3 591.8 594.8 611.7 7837.0 8736.4 8786.0 8799.6 9038.0 562.4 597.8 599.7 613.2 629.6 4125.7 4254.1 4273.6 4285.7 4381.9 98454.0 128968.7 131570.3 133814.0 141397.0 84258.2 121856.0 123121.8 124742.0 135281.0 101279.5 101787.0 103996.0 110682.8 111127.9 9335.5 9763.5 9831.3 9977.5 10003.5 59106.7 60317.7 61747.0 63284.8 64363.4 86477.6 87757.6 92932.5 94741.0 100471.5 12442.1 12620.0 12698.2 13087.7 13322.7 14588.1 14746.2 14801.9 14848.9 15131.1 13325.5 13348.6 13617.4 13636.7 13731.3 11555.1 12979.2 13678.4 13925.3 14161.0 12397.3 12701.2 13936.9 14158.9 14161.7 10968.0 11331.8 11794.1 11829.9 12113.2 11522.3 11543.9 11754.4 11791.9 11826.5 23:32:54 INFO - PROCESS | 1654 | -------- Summary: end -------- 23:32:54 INFO - PROCESS | 1654 | 23:32:55 INFO - TEST-INFO | 1654: exit 0 23:32:55 INFO - TEST-OK | dromaeo_css | took 1117928ms 23:32:55 INFO - TEST-START | kraken 23:32:55 INFO - operating with platform_type : mac_ 23:32:55 INFO - Initialising browser for kraken test... 23:32:55 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpUA2zJR/profile http://localhost:49277/getInfo.html) 23:32:57 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 23:32:57 INFO - PROCESS | 1664 | colorDepth:24 23:32:57 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 23:32:57 INFO - PROCESS | 1664 | __metrics 23:32:57 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:32:57 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:32:58 INFO - TEST-INFO | 1664: exit 0 23:32:58 INFO - Browser initialized. 23:32:58 INFO - Running cycle 1/1 for kraken test... 23:32:58 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpUA2zJR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:33:10 INFO - PROCESS | 1665 | RSS: Main: 220213248 23:33:10 INFO - PROCESS | 1665 | 23:33:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 23:33:13 INFO - PROCESS | 1665 | RSS: Main: 270053376 23:33:13 INFO - PROCESS | 1665 | 23:33:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 23:33:17 INFO - PROCESS | 1665 | RSS: Main: 280412160 23:33:17 INFO - PROCESS | 1665 | 23:33:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 23:33:20 INFO - PROCESS | 1665 | RSS: Main: 377204736 23:33:20 INFO - PROCESS | 1665 | 23:33:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 23:33:23 INFO - PROCESS | 1665 | RSS: Main: 280571904 23:33:23 INFO - PROCESS | 1665 | 23:33:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:33:26 INFO - PROCESS | 1665 | RSS: Main: 281448448 23:33:26 INFO - PROCESS | 1665 | 23:33:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 23:33:29 INFO - PROCESS | 1665 | RSS: Main: 318140416 23:33:29 INFO - PROCESS | 1665 | 23:33:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 23:33:32 INFO - PROCESS | 1665 | RSS: Main: 319467520 23:33:32 INFO - PROCESS | 1665 | 23:33:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 23:33:36 INFO - PROCESS | 1665 | RSS: Main: 317906944 23:33:36 INFO - PROCESS | 1665 | 23:33:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:33:38 INFO - PROCESS | 1665 | RSS: Main: 295780352 23:33:38 INFO - PROCESS | 1665 | 23:33:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:33:41 INFO - PROCESS | 1665 | RSS: Main: 298541056 23:33:41 INFO - PROCESS | 1665 | 23:33:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:33:44 INFO - PROCESS | 1665 | RSS: Main: 299732992 23:33:44 INFO - PROCESS | 1665 | 23:33:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:33:47 INFO - PROCESS | 1665 | RSS: Main: 309116928 23:33:47 INFO - PROCESS | 1665 | 23:33:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:33:51 INFO - PROCESS | 1665 | RSS: Main: 308420608 23:33:51 INFO - PROCESS | 1665 | 23:33:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 23:33:53 INFO - PROCESS | 1665 | RSS: Main: 352579584 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | __start_tp_report 23:33:53 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 23:33:53 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 23:33:53 INFO - PROCESS | 1665 | |i|pagename|runs| 23:33:53 INFO - PROCESS | 1665 | |0;ai-astar;115;114;114;113;114;114;114;113;114;114 23:33:53 INFO - PROCESS | 1665 | |1;audio-beat-detection;140;111;109;142;109;108;108;110;138;109 23:33:53 INFO - PROCESS | 1665 | |2;audio-dft;183;182;184;181;182;183;184;183;181;182 23:33:53 INFO - PROCESS | 1665 | |3;audio-fft;80;58;60;104;87;59;49;75;100;81 23:33:53 INFO - PROCESS | 1665 | |4;audio-oscillator;90;70;95;69;68;69;92;68;69;90 23:33:53 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;88;85;88;86;88;86;89;125;87;84 23:33:53 INFO - PROCESS | 1665 | |6;imaging-darkroom;96;97;96;99;97;97;96;97;96;97 23:33:53 INFO - PROCESS | 1665 | |7;imaging-desaturate;87;86;86;87;84;86;83;84;86;85 23:33:53 INFO - PROCESS | 1665 | |8;json-parse-financial;55;54;53;57;59;57;56;57;56;56 23:33:53 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;65;72;78;79;105;102;85;68;69;69 23:33:53 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;87;101;99;101;85;87;82;99;101;79 23:33:53 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;125;137;137;140;174;153;150;139;170;141 23:33:53 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;164;161;164;166;166;163;165;160;225;177 23:33:53 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;67;66;66;66;65;66;67;65;66 23:33:53 INFO - PROCESS | 1665 | __end_tp_report 23:33:53 INFO - PROCESS | 1665 | __start_cc_report 23:33:53 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1964 23:33:53 INFO - PROCESS | 1665 | __end_cc_report 23:33:53 INFO - PROCESS | 1665 | __startTimestamp1478327633186__endTimestamp 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | ------- Summary: start ------- 23:33:53 INFO - PROCESS | 1665 | Number of tests: 14 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 23:33:53 INFO - PROCESS | 1665 | Values: 115.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 114.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:118.40 Median:110.50 stddev:14.96 (13.5%) stddev-sans-first:13.67 23:33:53 INFO - PROCESS | 1665 | Values: 140.0 111.0 109.0 142.0 109.0 108.0 108.0 110.0 138.0 109.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.08 (0.6%) stddev-sans-first:1.13 23:33:53 INFO - PROCESS | 1665 | Values: 183.0 182.0 184.0 181.0 182.0 183.0 184.0 183.0 181.0 182.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:75.30 Median:67.50 stddev:18.61 (27.6%) stddev-sans-first:19.66 23:33:53 INFO - PROCESS | 1665 | Values: 80.0 58.0 60.0 104.0 87.0 59.0 49.0 75.0 100.0 81.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:80.00 stddev:11.93 (14.9%) stddev-sans-first:11.83 23:33:53 INFO - PROCESS | 1665 | Values: 90.0 70.0 95.0 69.0 68.0 69.0 92.0 68.0 69.0 90.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:87.50 stddev:12.19 (13.9%) stddev-sans-first:12.89 23:33:53 INFO - PROCESS | 1665 | Values: 88.0 85.0 88.0 86.0 88.0 86.0 89.0 125.0 87.0 84.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.93 23:33:53 INFO - PROCESS | 1665 | Values: 96.0 97.0 96.0 99.0 97.0 97.0 96.0 97.0 96.0 97.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.30 23:33:53 INFO - PROCESS | 1665 | Values: 87.0 86.0 86.0 87.0 84.0 86.0 83.0 84.0 86.0 85.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.70 (3.0%) stddev-sans-first:1.76 23:33:53 INFO - PROCESS | 1665 | Values: 55.0 54.0 53.0 57.0 59.0 57.0 56.0 57.0 56.0 56.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:79.20 Median:70.50 stddev:14.17 (20.1%) stddev-sans-first:14.07 23:33:53 INFO - PROCESS | 1665 | Values: 65.0 72.0 78.0 79.0 105.0 102.0 85.0 68.0 69.0 69.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:86.00 stddev:8.88 (10.3%) stddev-sans-first:9.22 23:33:53 INFO - PROCESS | 1665 | Values: 87.0 101.0 99.0 101.0 85.0 87.0 82.0 99.0 101.0 79.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:145.50 stddev:15.40 (10.6%) stddev-sans-first:14.21 23:33:53 INFO - PROCESS | 1665 | Values: 125.0 137.0 137.0 140.0 174.0 153.0 150.0 139.0 170.0 141.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:165.50 stddev:19.50 (11.8%) stddev-sans-first:20.51 23:33:53 INFO - PROCESS | 1665 | Values: 164.0 161.0 164.0 166.0 166.0 163.0 165.0 160.0 225.0 177.0 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 23:33:53 INFO - PROCESS | 1665 | Values: 67.0 67.0 66.0 66.0 66.0 65.0 66.0 67.0 65.0 66.0 23:33:53 INFO - PROCESS | 1665 | -------- Summary: end -------- 23:33:53 INFO - PROCESS | 1665 | 23:33:53 INFO - TEST-INFO | 1665: exit 0 23:33:54 INFO - TEST-OK | kraken | took 58864ms 23:33:54 INFO - SUITE-END | took 1176s 23:33:54 INFO - Completed test suite (00:19:37) 23:33:54 INFO - javascript benchmark 23:33:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.3717893600215, 3333.949990750139, 3361.2437201629623, 3370.7528214560616, 3400.8979730608075, 5683.914741278879, 5725.370209276986, 5761.1358296255585, 5773.797917072903, 5789.24739783828, 5662.745176467059, 5754.712264386774, 5764.884702305952, 5773.422657734224, 5783.508401785843, 4775.617950563964, 5188.066148093332, 5232.973835130819, 5251.975864706384, 5297.284866543006, 4990.226514890198, 5168.715720635363, 5171.198464238049, 5211.192265198882, 5241.161414173733, 5202.817901373433, 5227.973860130713, 5316.707581083039, 5326.2543243945875, 5348.411674715778, 4149.0, 5237.607179461536, 5301.681899086028, 5308.681479111266, 5353.892922141575, 5014.824481143179, 5106.795728170869, 5255.001549705544, 5258.079836028718, 5303.363596368422, 5586.748596313176, 5631.549476041907, 5659.320881494247, 5665.49010589049, 5674.858128546778, 6110.406879924458, 6143.801958618072, 6175.629462232236, 6176.320604733476, 6181.412765787288, 6224.408681175281, 6230.87538249237, 6232.252129744415, 6236.87526249477, 6239.594426362317, 5743.253377061039, 5818.301803783488, 5821.854453638693, 5920.881582368328, 5937.495312898409, 6244.968775156095, 6269.686515674198, 6272.5922815016875, 6273.560850740496, 6302.716377763011, 6164.4143806339225, 6165.167702360213, 6187.628742275478, 6192.380761923771, 6192.97815860387, 6104.298745950694, 6124.5100391968535, 6139.001538246403, 6204.565680402328, 6209.285932117774, 6124.289394097934, 6165.599236049642, 6166.568340216142, 6234.906476402857, 6253.374662533801, 6257.405546473078, 6264.404881536247, 6269.529785266032, 6277.497800175975, 6313.96843015782, 4830.637702172351, 4833.951660483421, 4906.95093049065, 4922.384701912261, 4925.75371231437, 4391.802368893407, 4445.1998640245065, 4461.063176732922, 4466.888327791831, 4506.7070640408265, 5784.768609255667, 5784.797532086357, 5796.82609521715, 5810.709464526757, 5819.621724587888, 6305.464035557029, 6310.148130002391, 6315.021171718391, 6322.525810564226, 6333.619982800955, 5706.828795136153, 5760.42395760429, 5779.739911703983, 5801.187833703285, 5823.88352232953, 5410.945890541123, 5447.6731396115565, 5465.9180112298345, 5467.863303417367, 5491.121420572769, 5283.260343551906, 5746.678263999303, 6295.874082518324, 6312.779052733133, 6320.08358787964, 6062.636241825505, 6173.84565385869, 6198.380161983946, 6346.841328966812, 6370.745170193326, 6250.3749625037135, 6286.057091436322, 6294.905576416449, 6306.0, 6330.208723909512, 6225.8132256032395, 6228.34602366745, 6231.439170474498, 6241.469475094668, 6245.094461303176, 6148.692565371803, 6282.623042617458, 6286.5599408041, 6316.810495685137, 6321.494280457644, 6068.362821903813, 6115.785947491817, 6127.158986117617, 6132.20254427538, 6221.564490485623, 6184.690765461799, 6184.8763024738355, 6185.474234690102, 6192.256929168529, 6204.751809927733, 6022.608530445507, 6049.667268300285, 6056.394360564084, 6066.787662431793, 6158.907616385668, 5979.611325263844, 5998.520118390431, 6005.249343832021, 6082.695865206811, 6091.147239386578, 5748.885022299614, 5927.762889484372, 5933.495652869382, 5942.702864856654, 5972.343042265435], "value": 5705.942882917578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.96998662968207, 470.87286432663205, 495.49212057640926, 536.554659632505, 542.8751387180948, 23617.645735313985, 38897.02757431062, 39939.0, 40142.992850357514, 40152.0, 41000.38499422511, 41437.58562414375, 41520.79239603805, 41647.0, 41780.58219417805, 8115.75652730419, 9736.853947190797, 9755.268354873377, 9759.926408095103, 9773.804523909517, 8598.269147122503, 8809.691660791874, 11828.408579570987, 12097.697557561043, 12111.939440302785, 11940.880591194107, 12045.819312710317, 12064.0, 12071.155019148664, 12074.396280186, 11875.16873818833, 11967.461464234044, 11979.700507487383, 11983.041356691443, 11992.100592455601, 11703.88296117045, 11782.057435405148, 11800.40997950099, 11809.173357864953, 11810.40947952599, 39017.82946511609, 39227.60772392296, 39227.8038609808, 39235.01912452183, 39253.0, 2709.9322516937036, 3344.2308269098244, 3440.535527703753, 3602.35157671619, 3664.926701465956, 29024.41951160965, 30045.849770751225, 30215.244618884703, 30467.847660761556, 30700.2324941876, 3109.9844500777576, 3147.5750773645723, 3175.6348019977536, 3222.871085156591, 3280.950785738216, 490279.54860225826, 491473.8836752355, 493529.5323523359, 493867.0, 494708.0, 33167.83912563097, 33449.83275083609, 33826.32347353089, 54985.725071375186, 55426.891462171334, 34906.65093349085, 34936.475952860725, 35001.474977875354, 35101.824490877385, 35167.296654067286, 14445.855541444662, 14494.637634059021, 14593.92703036478, 14595.92702036483, 14665.120092794466, 11041.668749937515, 11311.660650180507, 12280.0, 12429.689257768447, 12431.31627760482, 7275.927240727631, 7504.212057733968, 7681.116671582728, 7694.0767107946285, 7694.192109828499, 2906.215321863085, 3167.7329068372374, 3246.5130230465147, 3256.348730253959, 3278.7213086887405, 902.6434558349547, 971.4122955611895, 992.4591097851688, 1080.5191689698165, 1132.3375825142384, 29525.0, 29847.850760746056, 30092.0, 30290.69709302923, 30308.696913031028, 1045.278757657214, 1112.2158877990996, 1128.3230061962756, 1145.6906635208447, 1153.7923173828792, 13032.41354139066, 15311.770323445156, 15328.707632406618, 15374.923125384525, 15617.765733514007, 205057.0, 206851.0, 207591.96204018884, 207596.96201518897, 208019.0, 55826.72086639622, 56078.43921560814, 56108.719456402454, 56137.71931140318, 56241.15638265429, 1220.6582156995878, 1248.1263115818963, 1344.515974249289, 1355.8101865738804, 1366.3782978744846, 25684.0, 30036.699633004264, 30416.847915760278, 30657.386852262385, 31050.534241985937, 46697.53302466932, 47166.0, 47231.0, 47290.52709472999, 47406.28890566575, 465759.0, 466318.0, 467843.0, 468526.0, 680099.0, 39810.40284395794, 40388.0, 40441.0, 40505.392419113145, 40776.59223407728, 44503.55496444994, 44602.55397445984, 44955.77522112369, 45010.32484512669, 45336.77331613321, 32030.839845800623, 36516.0, 37205.255894882495, 39645.00887477836, 41011.38482922699, 37525.81237093797, 37646.43530346992, 38421.807890961485, 38492.42261366026, 39612.60387396089, 36627.45058824173, 36955.07612309714, 37400.812995934844, 37632.43551346677, 37700.0, 32399.838000809847, 33566.832165839995, 34049.65950340564, 34312.485312720826, 34415.0, 25328.986840526173, 25382.111626093, 25579.0, 25628.103016394336, 25705.485890282464], "value": 18193.36683912149, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.1899155975018, 368.5724559510968, 372.6162053085323, 379.2301627695779, 396.3974758367282, 15032.022918510303, 15133.697326053472, 16230.350785968547, 20771.376858694224, 21216.15135394586, 19177.52056198596, 19839.702404463907, 20325.186992520317, 20565.485862853435, 20910.0, 5140.203268493371, 5857.209276747627, 6120.449159575637, 6123.0, 6123.877522449548, 5974.0, 6020.969895150518, 6081.391860813927, 6083.847903802396, 6089.360617135181, 4945.307656928033, 5194.168932970725, 5764.7982320618785, 5865.736041878125, 6042.425969532887, 5946.940530594704, 5981.491573216282, 5985.880282394328, 5986.730597123096, 5988.101784732282, 5034.169362055257, 5160.664556803796, 5175.987543513415, 5227.2159176123505, 5231.659942103751, 26406.0, 26489.337766555796, 26560.86719566409, 26755.190704976085, 26868.328291792666, 2074.3258441006583, 2213.1479380438486, 2434.221049264236, 2459.225344016629, 2997.865096070682, 10367.48162591875, 10396.376217426978, 11225.438728063564, 15161.241937903062, 15184.164870932094, 1741.9651606967916, 1810.5021119192327, 1837.8162183781649, 1876.6434377468238, 1928.633559623681, 106840.39739403916, 115230.42384788023, 119171.0, 122447.16329255157, 124886.37556812249, 9143.725688229364, 11371.431428428545, 11580.247283926517, 11639.243449175945, 11822.527098915947, 11897.821532677017, 14471.638209044859, 14510.0, 14547.709045819236, 14567.344469498898, 8222.547759873265, 8423.410361274775, 8465.873011904827, 8568.742937711879, 8578.670306102564, 8161.0, 8330.166983301622, 8343.666253349798, 8446.535440550706, 8491.278241349555, 4456.888577785581, 4507.504174540798, 4530.45964372115, 4556.430446194226, 4624.28323609841, 1846.270723064382, 1897.6679081160742, 1901.657701613695, 1902.7811801642988, 1909.465349702058, 838.5597561280376, 865.1175800683268, 909.9863502047475, 927.5084205371164, 1044.2324891204958, 20838.895805520875, 21518.46203844885, 21559.137634494757, 21698.0, 21770.891145544487, 946.8437707778277, 948.6158105966956, 955.1594596754811, 960.9759756006016, 1001.5993602558889, 10849.945750271198, 11327.300904864336, 11438.542458301741, 11535.96176344133, 11572.942135289439, 545279.0, 571131.0, 601582.0, 630012.0, 637232.0, 81123.0, 126309.31608077475, 127408.0, 129408.0, 135460.32269838784, 946.5314669238771, 994.7314225159312, 1024.1806554756165, 1024.5184763161303, 1026.235454586338, 16483.258253378866, 17904.820951790316, 19371.3220037298, 20316.390508284774, 20376.98115094269, 58082.4191758077, 58712.412875870694, 59484.70257648857, 60132.39867601268, 60325.0, 69797.65101174462, 72576.63711681408, 81895.590522047, 82313.0, 83086.16913830784, 7552.234040430236, 7893.210678932061, 8137.389695772722, 8286.337093032422, 8454.91545084566, 12005.339706316236, 12984.805227921399, 13191.142575732547, 13504.864951350753, 13620.93189534046, 11273.323600583662, 11422.97193252578, 11430.1998860079, 11751.823722644338, 11763.882431169026, 9949.751256218653, 10775.6228532001, 11139.10887129044, 11534.120163174872, 11663.533458661559, 11435.771284574428, 11466.2546934449, 11601.419929003685, 11805.23265987708, 11972.341521216416, 7900.68397264103, 7929.801754956172, 8064.556449395105, 8125.228103330174, 8198.221168988937, 8682.262007729161, 9316.394434361744, 11357.716057098638, 11605.361705106301, 11675.416229188677], "value": 9610.937433169993, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.5908148014855, 1541.437375357994, 1573.6773961337926, 1699.8045224799143, 1879.0322983663407, 8138.145494723058, 8390.328773698106, 8598.398112132154, 9164.175224229817, 9175.678851240216, 7360.411167106632, 7813.843723125534, 8246.46397984132, 8814.4711317321, 8903.554822258877, 2372.608519594269, 2411.4212588978694, 2417.2506522977847, 2417.5406672732124, 2417.625268083441, 2120.0777661717125, 2364.988175059122, 2385.141349114326, 2442.4016116051594, 2450.644656524803, 2167.837412194092, 2197.099189332374, 2361.645753137026, 2426.235735743235, 2433.8174636902304, 2376.144587948337, 2380.8690522021284, 2383.809295256375, 2390.414348484615, 2391.0794344177443, 2407.735149133594, 2412.360724408033, 2413.251891913495, 2415.215055107097, 2420.8426452280546, 8931.062238464932, 9003.234725048378, 9069.773255668595, 9081.68214112503, 9085.727428177166, 5260.316158899357, 5403.432639572867, 5464.207689884945, 5464.781408743645, 5465.207544905967, 3457.2048428861503, 3526.6825985661158, 3652.7990960497164, 3654.524911761481, 3655.5430571178604, 1041.9791604167874, 1070.0850772589401, 1072.7103682005816, 1089.1559041742712, 1091.2743025887776, 11965.700857478545, 12080.335581543011, 12083.154179207459, 12108.636740897788, 12132.0, 4693.48371679115, 4766.293614219895, 4794.664373493822, 4899.657024008286, 4928.112939670822, 10011.699649010541, 10263.435511046964, 10266.332688375232, 10271.332363396356, 10275.972402759664, 5442.9930462864495, 5459.1265397537, 5461.180822876521, 5468.671879687232, 5469.535089517356, 4931.334269873521, 4936.086823937583, 4941.43173535048, 4971.825986090469, 5004.674696144739, 3333.333333333343, 3994.3409337458993, 4035.334169861999, 4056.9797151014054, 4108.36320370343, 1079.5897558927713, 1176.8757392905716, 1272.7899896516972, 1277.9552715654906, 1293.9417726202344, 784.9450538462366, 885.2298500304776, 888.4092078767547, 912.4753266871576, 952.1782810311613, 5823.650580965155, 5854.8536286592325, 5883.0, 5917.260342457193, 6086.330503644595, 815.7756616930272, 937.0488953711988, 942.3780304998668, 976.8778902637171, 1031.118393773313, 3392.6268110507826, 3608.657177568127, 3680.4663323817895, 3698.4452332150395, 3729.384651532521, 10766.676999690022, 10952.123830093573, 11027.0075693188, 11085.944570277097, 11137.387443690675, 10879.728006799893, 10887.292325998786, 10894.509747061402, 10897.019268265894, 10990.725231869268, 8007.359411247086, 8244.711435099744, 8401.327893768485, 8419.0, 8427.325813934993, 5884.382139875252, 5949.1076338549565, 6038.939610604013, 6051.001584738468, 6052.878942421215, 10177.0, 10215.02957219063, 10227.0, 10346.120579750805, 10353.223508237063, 10019.448930308903, 10172.08451239392, 10534.42060686639, 10548.578056877639, 10555.841662374916, 7365.8158546036775, 7507.962460187664, 7520.736774212876, 7522.322990930843, 7524.360429363565, 7978.561179135203, 8065.274125328749, 8142.959285203536, 8143.104258531438, 8165.469244499089, 7112.039874617068, 7421.257874212535, 7524.322810947041, 7533.472656913963, 7560.810979725331, 7301.561906285639, 7390.852182956418, 7404.888926666212, 7413.629318534159, 7444.292792184734, 6796.76211332601, 6797.286284940208, 6914.274001229798, 6919.65066811987, 6948.270431604608, 4835.347228124158, 4842.128416884994, 4991.4061875449615, 4991.675541089818, 5132.281480592795, 4938.975305123451, 4995.725235112103, 5068.0, 5108.770105345194, 5114.258432527188], "value": 4615.262611062696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.25386913519907, 303.3145092091872, 308.91968088297034, 313.84464689978466, 315.6922001048979, 4483.439570053743, 5007.324011258479, 5071.315372424726, 5234.717494213918, 5461.262729531517, 4186.958130418695, 5050.6969581825115, 5109.897802043957, 5208.5572726318305, 5210.635255532115, 3782.829772660223, 3798.0504873781556, 4124.443200167984, 4147.129102888382, 4156.937645935313, 4121.5466298707115, 4138.4413104231, 4151.356539736331, 4160.689382844409, 4217.15656868626, 3468.514407982884, 3813.0344441780517, 4099.483147060119, 4153.646940010103, 4159.875203743893, 4089.9795501022304, 4122.42286079949, 4127.938080928789, 4130.80206740045, 4132.8966775830695, 3293.5059741039036, 3342.2145795737983, 3598.24436868258, 3598.748087633867, 3599.586047604507, 4614.723116613014, 4957.702537847741, 5292.285541451894, 5321.946780532184, 5325.360956685184, 3736.9439458408146, 3966.8099570128848, 4359.975405779639, 4725.881852953669, 4784.976075119637, 4869.70781753096, 5666.235058267122, 5736.6558006519745, 5772.913406298909, 5782.306123265193, 3469.3061387722555, 3969.3527186217684, 3990.7628635123206, 4005.5794141615, 4031.475908131924, 4936.456989731127, 5664.20701101846, 5720.456556627156, 5896.675682837442, 6034.818955431344, 3335.0, 4001.619846114673, 4013.3979903014197, 4060.614241647098, 4105.0, 3933.3903244997073, 4101.5488296287385, 4133.607307305801, 4147.6474499667265, 4167.333226683716, 4264.509581398117, 4559.974005848658, 4645.790939407667, 4766.404199475066, 4820.807167713322, 5166.3025491558155, 5682.783714351406, 5683.2895888014, 5685.508448325776, 5689.601727879091, 1326.396489597231, 1369.383777300199, 1412.5338638249352, 1412.5974097382198, 1416.9574912752635, 811.4157806379397, 869.8825658536017, 937.1378331934636, 945.6241169098945, 970.3304719743354, 4677.18149323867, 4742.359781429532, 4868.367112275381, 5247.527722504993, 5256.842294731087, 5898.8230353089475, 5906.734196961147, 5934.673592952343, 5969.970150149222, 6009.759609615654, 4773.689710168828, 4843.297721830315, 5163.683260768556, 5385.2841539338515, 5562.3881373048935, 2574.5365834149657, 2662.1348061879967, 3122.297483066292, 3131.5459258407404, 3142.340108577179, 5487.9420217418465, 5510.752016159283, 5792.94207057924, 6071.785642871355, 6089.995150800157, 4593.770311484413, 5169.508896654812, 5933.436323549256, 5982.713716550962, 6101.84745381369, 5277.815276465305, 6118.632882027093, 6163.753449862045, 6189.938100619026, 6296.087067375205, 5705.4009329019855, 5930.0, 5975.922399964109, 5982.46157845796, 6031.668258245839, 5873.911891321548, 5874.353821079763, 5910.586258962004, 5916.0, 5921.259842519685, 5175.430702622633, 5307.77953961932, 6064.666443345658, 6135.53983451234, 6264.68676566179, 3505.1237190702323, 3912.9043867717087, 3943.5859234779937, 3962.5244970603712, 3988.3818008208773, 5996.72124592652, 6022.789202377896, 6058.697065146637, 6068.4841788448475, 6069.177832307998, 5372.946270537244, 5577.581681373832, 5841.860837136717, 5853.560982926212, 5900.64596124234, 5763.337216220189, 5769.394213607511, 5775.48020678141, 5778.0, 5817.650940943557, 5229.450907654794, 5265.921011184912, 5450.31871016123, 5648.83053508379, 5720.313562372542, 4798.640101992434, 4958.801647934187, 5000.624828172136, 5681.289838770153, 5781.971090144522, 5052.520010598987, 5196.636235463632, 5631.577631677558, 5682.971585142213, 5712.714364281853], "value": 4170.827479137236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.8149758816322, 708.5288283291611, 722.9060222171117, 745.7017193122751, 748.7042618165826, 14059.086159399632, 15080.849191508081, 15110.924445377757, 15132.394704211833, 15140.84859151408, 13214.603561893158, 13323.933380333085, 13342.0, 13346.399412026458, 13350.332483375816, 667.7362441835472, 686.1834417043702, 690.6167077272112, 821.5194111444782, 844.9408541402104, 836.573347592726, 852.0201767966826, 852.7356519478982, 853.5305581929945, 854.3165467625905, 811.2941740685612, 893.1291990309429, 903.7243640689587, 904.6471875968377, 908.9091090890892, 702.3012102957539, 721.6932803558519, 862.0732712334266, 905.5879574793453, 906.7461110888962, 661.0909998751716, 665.5607299182516, 666.3070406776947, 666.3170250493283, 666.8166254280063, 14151.150930944177, 14174.07868488545, 14181.78727319091, 14189.43242270308, 14218.50235241772, 11033.668989930315, 12813.23120612757, 12826.23042617446, 12852.485900563966, 12985.0, 11774.116941229357, 11959.820602690967, 12011.399638911982, 12301.569445069379, 12346.876531234662, 4144.585541445861, 4330.5946830919165, 4380.386745855582, 4469.709468884512, 4471.23988921884, 119683.40158299153, 120000.3999880005, 120663.99999999913, 122104.54118477365, 125709.37145314306, 9969.35199212049, 9988.101070903653, 10536.262461627612, 10554.894451055545, 10586.0, 20117.798822011886, 20118.59762804736, 20127.993600319925, 20144.496387590134, 20146.19415223404, 6080.939190608037, 6908.6545672716165, 7153.213146553875, 7425.702971881173, 7448.255174482617, 3203.9266845606517, 3916.686665066788, 3980.3631418972827, 4086.59134086589, 4108.157827645326, 3143.795653282575, 3278.164068162651, 3283.2120291130436, 3295.9340813183603, 3303.0, 616.8673735146965, 618.6985552151264, 620.3703241210176, 623.2147494157394, 632.7279269913981, 581.8516278348994, 590.2887021139517, 591.8106206014035, 594.7502049139372, 611.6635850282327, 7836.960815196002, 8736.388452808369, 8785.956070219736, 8799.648014079494, 9037.954810226038, 562.3869981719945, 597.8087012156068, 599.7331187621467, 613.187526527353, 629.6242709679365, 4125.690573207022, 4254.127903779779, 4273.55127711592, 4285.678574106954, 4381.9342709859375, 98454.0, 128968.71031289754, 131570.34214828865, 133814.0, 141397.0, 84258.15741842626, 121856.0, 123121.76878231282, 124742.0, 135281.0, 101279.49360253151, 101786.98213017923, 103996.0, 110682.78634427267, 111127.88872111498, 9335.486548239913, 9763.463009534544, 9831.311808173645, 9977.45124018157, 10003.549840257061, 59106.70446647739, 60317.69841150766, 61747.0, 63284.75950476601, 64363.35636643761, 86477.56761216154, 87757.56121219353, 92932.53533732289, 94741.0, 100471.49764251131, 12442.129050966345, 12620.0, 12698.238105713686, 13087.738245234852, 13322.733545329233, 14588.051776634486, 14746.162810386268, 14801.925990369979, 14848.886333524813, 15131.092134471966, 13325.53360632412, 13348.599542013755, 13617.387217575035, 13636.727265454834, 13731.313434328444, 11555.133364997491, 12979.221246725227, 13678.384472698952, 13925.303734813016, 14161.0, 12397.256164630151, 12701.22182894414, 13936.860631393962, 14158.858411415755, 14161.716765664834, 10968.0, 11331.830022549833, 11794.142226113214, 11829.881701182878, 12113.212641178296, 11522.251053681484, 11543.88456115428, 11754.353510557, 11791.88208117908, 11826.467808948446], "value": 7554.158997103539, "unit": "score"}], "name": "dromaeo_css", "value": 7248.954995237268, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 109.0, 142.0, 109.0, 108.0, 108.0, 110.0, 138.0, 109.0], "value": 118.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 181.0, 182.0, 183.0, 184.0, 183.0, 181.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 104.0, 87.0, 59.0, 49.0, 75.0, 100.0, 81.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 95.0, 69.0, 68.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 86.0, 89.0, 125.0, 87.0, 84.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 99.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 84.0, 86.0, 83.0, 84.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 57.0, 59.0, 57.0, 56.0, 57.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 78.0, 79.0, 105.0, 102.0, 85.0, 68.0, 69.0, 69.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 101.0, 99.0, 101.0, 85.0, 87.0, 82.0, 99.0, 101.0, 79.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 137.0, 137.0, 140.0, 174.0, 153.0, 150.0, 139.0, 170.0, 141.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 166.0, 166.0, 163.0, 165.0, 160.0, 225.0, 177.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1451.9999999999998, "alertThreshold": 2.0}]} 23:33:54 INFO - Return code: 0 23:33:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:33:54 INFO - # TBPL SUCCESS # 23:33:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:33:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:33:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:33:54 INFO - 2016-11-04 23:33:54.511 screenresolution[1669:10226] starting screenresolution argv=screenresolution get 23:33:54 INFO - 2016-11-04 23:33:54.513 screenresolution[1669:10226] Display 0: 1600x1200x32@60 23:33:54 INFO - 2016-11-04 23:33:54.519 screenresolution[1670:10229] starting screenresolution argv=screenresolution list 23:33:54 INFO - Available Modes on Display 0 23:33:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:33:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:33:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:33:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:33:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:33:54 INFO - Intel Iris: 23:33:54 INFO - Chipset Model: Intel Iris 23:33:54 INFO - Type: GPU 23:33:54 INFO - Bus: Built-In 23:33:54 INFO - VRAM (Dynamic, Max): 1536 MB 23:33:54 INFO - Vendor: Intel (0x8086) 23:33:54 INFO - Device ID: 0x0a2e 23:33:54 INFO - Revision ID: 0x0009 23:33:54 INFO - Displays: 23:33:54 INFO - Display: 23:33:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:33:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:33:54 INFO - Display Serial Number: 1600x1200 60 23:33:54 INFO - Main Display: Yes 23:33:54 INFO - Mirror: Off 23:33:54 INFO - Online: Yes 23:33:54 INFO - Rotation: Supported 23:33:54 INFO - Return code: 0 23:33:54 INFO - Running post-action listener: _resource_record_post_action 23:33:54 INFO - [mozharness: 2016-11-05 06:33:54.757072Z] Finished run-tests step (success) 23:33:54 INFO - Running post-run listener: _resource_record_post_run 23:33:54 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37532672; Write bytes: 662947840; Read time: 242; Write time: 1905 23:33:54 INFO - TinderboxPrint: CPU usage
53.2% 23:33:54 INFO - TinderboxPrint: I/O read bytes / time
37,532,672 / 242 23:33:54 INFO - TinderboxPrint: I/O write bytes / time
662,947,840 / 1,905 23:33:54 INFO - TinderboxPrint: CPU idle
2,266.2 (46.8%) 23:33:54 INFO - TinderboxPrint: CPU system
963.9 (19.9%) 23:33:54 INFO - TinderboxPrint: CPU user
1,611.5 (33.3%) 23:33:54 INFO - TinderboxPrint: Swap in / out
400,998,400 / 0 23:33:54 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354771456; Write bytes: 355547136; Read time: 27705; Write time: 739 23:33:54 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36578304; Write bytes: 297242624; Read time: 230; Write time: 1130 23:33:55 INFO - Running post-run listener: _upload_blobber_files 23:33:55 INFO - Blob upload gear active. 23:33:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:33:55 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 23:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:33:55 INFO - (blobuploader) - INFO - Open directory for files ... 23:33:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:33:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:56 INFO - (blobuploader) - INFO - Done attempting. 23:33:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:33:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:57 INFO - (blobuploader) - INFO - Done attempting. 23:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:34:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:34:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:34:00 INFO - (blobuploader) - INFO - Done attempting. 23:34:00 INFO - (blobuploader) - INFO - Iteration through files over. 23:34:00 INFO - Return code: 0 23:34:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:34:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:34:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ec3998479b4bccd23122f684f598e15ed8796b130b95d16b46ee4792f3af12119cd1f575c6a2c27c5b521b0a0433020213bf5b7cb2fbb2f3d1bb693d19742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89bdba86cdc77f8ba4e1f2b2c2e8549a55bff062754922dfbe958674970bb3388c3c4066b30c57141df47dc82ea69398f4c599aa053e4ce0ff5824ecd1218dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/330868fdb4afae358a37a2a3a717a554b695f19de45b4f9764e2cc9503bcf495694daf623a8fc9ef07b064b73bd1b1aaeca5909d3d1681adb00945e804e75267"} 23:34:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:34:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:34:00 INFO - Contents: 23:34:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ec3998479b4bccd23122f684f598e15ed8796b130b95d16b46ee4792f3af12119cd1f575c6a2c27c5b521b0a0433020213bf5b7cb2fbb2f3d1bb693d19742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89bdba86cdc77f8ba4e1f2b2c2e8549a55bff062754922dfbe958674970bb3388c3c4066b30c57141df47dc82ea69398f4c599aa053e4ce0ff5824ecd1218dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/330868fdb4afae358a37a2a3a717a554b695f19de45b4f9764e2cc9503bcf495694daf623a8fc9ef07b064b73bd1b1aaeca5909d3d1681adb00945e804e75267"} 23:34:00 INFO - Running post-run listener: copy_logs_to_upload_dir 23:34:00 INFO - Copying logs to upload dir... 23:34:00 INFO - mkdir: /builds/slave/test/build/upload/logs 23:34:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.546215 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-04 23:34:00.223970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 23:34:00.227433) ========= 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.PxoaWNNpys/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.UxQNJcb8kY/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-Aurora/sha512/e64ec3998479b4bccd23122f684f598e15ed8796b130b95d16b46ee4792f3af12119cd1f575c6a2c27c5b521b0a0433020213bf5b7cb2fbb2f3d1bb693d19742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89bdba86cdc77f8ba4e1f2b2c2e8549a55bff062754922dfbe958674970bb3388c3c4066b30c57141df47dc82ea69398f4c599aa053e4ce0ff5824ecd1218dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/330868fdb4afae358a37a2a3a717a554b695f19de45b4f9764e2cc9503bcf495694daf623a8fc9ef07b064b73bd1b1aaeca5909d3d1681adb00945e804e75267"} build_url:https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/UZjLu7A7QJiNaFWnhhoSzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e64ec3998479b4bccd23122f684f598e15ed8796b130b95d16b46ee4792f3af12119cd1f575c6a2c27c5b521b0a0433020213bf5b7cb2fbb2f3d1bb693d19742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89bdba86cdc77f8ba4e1f2b2c2e8549a55bff062754922dfbe958674970bb3388c3c4066b30c57141df47dc82ea69398f4c599aa053e4ce0ff5824ecd1218dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/330868fdb4afae358a37a2a3a717a554b695f19de45b4f9764e2cc9503bcf495694daf623a8fc9ef07b064b73bd1b1aaeca5909d3d1681adb00945e804e75267"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 23:34:00.260508) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 23:34:00.260831) ========= 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.PxoaWNNpys/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.UxQNJcb8kY/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005167 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 23:34:00.308976) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 23:34:00.309292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 23:34:00.309599) ========= ========= Total master_lag: 0.90 =========