builder: jamun_yosemite_r7_devedition_test-dromaeojs slave: t-yosemite-r7-0372 starttime: 1495470168.41 results: success (0) buildid: 20170522053521 builduid: 466552d1076d4352bc2e798d63ebe309 revision: 44293893aae54b139118c47c3f771a6b71748d3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.414818) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.415342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.415633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.440512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.441024) ========= 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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-22 09:22:48-- 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% 138M=0s 2017-05-22 09:22:48 (138 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.578397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.578733) ========= 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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.026964 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:48.626772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-22 09:22:48.627161) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev 44293893aae54b139118c47c3f771a6b71748d3b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev 44293893aae54b139118c47c3f771a6b71748d3b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-22 09:22:48,723 truncating revision to first 12 chars 2017-05-22 09:22:48,723 Setting DEBUG logging. 2017-05-22 09:22:48,723 attempt 1/10 2017-05-22 09:22:48,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/44293893aae5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-22 09:22:49,891 unpacking tar archive at: jamun-44293893aae5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-22 09:22:50.084806) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:50.085198) ========= script_repo_revision: 44293893aae54b139118c47c3f771a6b71748d3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:50.085659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:50.085959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 09:22:50.104273) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 26 secs) (at 2017-05-22 09:22:50.104664) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 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', 'Jamun', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Jamun'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:22:50 INFO - MultiFileLogger online at 20170522 09:22:50 in /builds/slave/test 09:22:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 09:22:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:50 INFO - {'append_to_log': False, 09:22:50 INFO - 'base_work_dir': '/builds/slave/test', 09:22:50 INFO - 'blob_upload_branch': 'Jamun', 09:22:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:50 INFO - 'branch': 'Jamun', 09:22:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:50 INFO - 'config_files': ('talos/mac_config.py',), 09:22:50 INFO - 'default_actions': ('clobber', 09:22:50 INFO - 'read-buildbot-config', 09:22:50 INFO - 'download-and-extract', 09:22:50 INFO - 'populate-webroot', 09:22:50 INFO - 'create-virtualenv', 09:22:50 INFO - 'install', 09:22:50 INFO - 'run-tests'), 09:22:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:50 INFO - 'download_minidump_stackwalk': True, 09:22:50 INFO - 'download_symbols': 'ondemand', 09:22:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:50 INFO - 'gecko_profile': False, 09:22:50 INFO - 'gecko_profile_interval': 0, 09:22:50 INFO - 'installer_path': 'installer.exe', 09:22:50 INFO - 'log_level': 'info', 09:22:50 INFO - 'log_name': 'talos', 09:22:50 INFO - 'log_to_console': True, 09:22:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:22:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:22:50 INFO - 'opt_config_files': (), 09:22:50 INFO - 'pip_index': False, 09:22:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:50 INFO - 'cmd': ('bash', 09:22:50 INFO - '-c', 09:22:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:50 INFO - 'enabled': True, 09:22:50 INFO - 'halt_on_failure': False, 09:22:50 INFO - 'name': 'check_screen_resolution'},), 09:22:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:22:50 INFO - 'cmd': ('bash', 09:22:50 INFO - '-c', 09:22:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:22:50 INFO - 'enabled': True, 09:22:50 INFO - 'halt_on_failure': False, 09:22:50 INFO - 'name': 'check_screen_resolution'},), 09:22:50 INFO - 'run_cmd_checks_enabled': True, 09:22:50 INFO - 'suite': 'dromaeojs', 09:22:50 INFO - 'system_bits': '32', 09:22:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:50 INFO - 'title': 't-yosemite-r7-0372', 09:22:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:50 INFO - 'use_talos_json': True, 09:22:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:50 INFO - 'work_dir': 'build'} 09:22:50 INFO - [mozharness: 2017-05-22 16:22:50.310578Z] Running clobber step. 09:22:50 INFO - Running pre-action listener: _resource_record_pre_action 09:22:50 INFO - Running main action method: clobber 09:22:50 INFO - rmtree: /builds/slave/test/build 09:22:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:52 INFO - Running post-action listener: _resource_record_post_action 09:22:52 INFO - [mozharness: 2017-05-22 16:22:52.680894Z] Finished clobber step (success) 09:22:52 INFO - [mozharness: 2017-05-22 16:22:52.681127Z] Running read-buildbot-config step. 09:22:52 INFO - Running pre-action listener: _resource_record_pre_action 09:22:52 INFO - Running main action method: read_buildbot_config 09:22:52 INFO - Using buildbot properties: 09:22:52 INFO - { 09:22:52 INFO - "project": "", 09:22:52 INFO - "product": "firefox", 09:22:52 INFO - "script_repo_revision": "production", 09:22:52 INFO - "builddir": "jamun_yosemite_r7_devedition_test-dromaeojs", 09:22:52 INFO - "repository": "", 09:22:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition jamun talos dromaeojs", 09:22:52 INFO - "buildid": "20170522053521", 09:22:52 INFO - "pgo_build": "False", 09:22:52 INFO - "basedir": "/builds/slave/test", 09:22:52 INFO - "buildnumber": 0, 09:22:52 INFO - "slavename": "t-yosemite-r7-0372", 09:22:52 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:22:52 INFO - "platform": "yosemite_r7_devedition", 09:22:52 INFO - "scheduler": "tests-jamun-macosx64-devedition-talos", 09:22:52 INFO - "branch": "jamun", 09:22:52 INFO - "repo_path": "projects/jamun", 09:22:52 INFO - "revision": "44293893aae54b139118c47c3f771a6b71748d3b", 09:22:52 INFO - "stage_platform": "macosx64-devedition", 09:22:52 INFO - "builduid": "466552d1076d4352bc2e798d63ebe309", 09:22:52 INFO - "slavebuilddir": "test" 09:22:52 INFO - } 09:22:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 09:22:52 INFO - Running post-action listener: _resource_record_post_action 09:22:52 INFO - [mozharness: 2017-05-22 16:22:52.686873Z] Finished read-buildbot-config step (success) 09:22:52 INFO - [mozharness: 2017-05-22 16:22:52.687031Z] Running download-and-extract step. 09:22:52 INFO - Running pre-action listener: _resource_record_pre_action 09:22:52 INFO - Running main action method: download_and_extract 09:22:52 INFO - mkdir: /builds/slave/test/build/tests 09:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:52 INFO - trying https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 09:22:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 09:22:53 INFO - Downloaded 1287 bytes. 09:22:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:22:53 INFO - Using the following test package requirements: 09:22:53 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 09:22:53 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:22:53 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 09:22:53 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 09:22:53 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:22:53 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 09:22:53 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:22:53 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 09:22:53 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 09:22:53 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 09:22:53 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:22:53 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 09:22:53 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 09:22:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:22:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:22:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:22:55 INFO - Expected file size: 51797380 09:22:55 INFO - Obtained file size: 51797380 09:23:11 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:23:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:23:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:23:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:23:13 INFO - Expected file size: 51797380 09:23:13 INFO - Obtained file size: 51797380 09:23:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 09:23:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 09:23:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 09:23:29 INFO - Expected file size: 14404449 09:23:29 INFO - Obtained file size: 14404449 09:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:30 INFO - trying https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:23:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 09:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 09:23:32 INFO - Downloaded 74766470 bytes. 09:23:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:23:32 INFO - mkdir: /builds/slave/test/properties 09:23:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:32 INFO - Contents: 09:23:32 INFO - build_url:https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:23:32 INFO - Running post-action listener: _resource_record_post_action 09:23:32 INFO - Running post-action listener: set_extra_try_arguments 09:23:32 INFO - [mozharness: 2017-05-22 16:23:32.728392Z] Finished download-and-extract step (success) 09:23:32 INFO - [mozharness: 2017-05-22 16:23:32.728555Z] Running populate-webroot step. 09:23:32 INFO - Running pre-action listener: _resource_record_pre_action 09:23:32 INFO - Running main action method: populate_webroot 09:23:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:32 INFO - '--tppagecycles', 09:23:32 INFO - '7'], 09:23:32 INFO - 'tests': ['tsvgm']}}, 09:23:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['damp', 'tps']}, 09:23:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'tests': ['damp', 'tps']}, 09:23:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['dromaeo_dom']}, 09:23:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['basic_compositor_video']}, 09:23:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:23:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['a11yr', 09:23:32 INFO - 'ts_paint', 09:23:32 INFO - 'tpaint', 09:23:32 INFO - 'sessionrestore', 09:23:32 INFO - 'sessionrestore_no_auto_restore', 09:23:32 INFO - 'tabpaint']}, 09:23:32 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:32 INFO - 'ts_paint', 09:23:32 INFO - 'tpaint', 09:23:32 INFO - 'sessionrestore', 09:23:32 INFO - 'sessionrestore_no_auto_restore', 09:23:32 INFO - 'tabpaint']}, 09:23:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:32 INFO - 'ts_paint', 09:23:32 INFO - 'tpaint', 09:23:32 INFO - 'sessionrestore', 09:23:32 INFO - 'sessionrestore_no_auto_restore', 09:23:32 INFO - 'tabpaint']}, 09:23:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:32 INFO - 'ts_paint', 09:23:32 INFO - 'tpaint', 09:23:32 INFO - 'sessionrestore', 09:23:32 INFO - 'sessionrestore_no_auto_restore', 09:23:32 INFO - 'tabpaint']}, 09:23:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['a11yr', 09:23:32 INFO - 'ts_paint', 09:23:32 INFO - 'tpaint', 09:23:32 INFO - 'sessionrestore', 09:23:32 INFO - 'sessionrestore_no_auto_restore', 09:23:32 INFO - 'tabpaint']}, 09:23:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['a11yr', 09:23:32 INFO - 'ts_paint', 09:23:32 INFO - 'tpaint', 09:23:32 INFO - 'sessionrestore', 09:23:32 INFO - 'sessionrestore_no_auto_restore', 09:23:32 INFO - 'tabpaint']}, 09:23:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['tsvgx', 09:23:32 INFO - 'tsvgr_opacity', 09:23:32 INFO - 'tart', 09:23:32 INFO - 'tscrollx', 09:23:32 INFO - 'cart', 09:23:32 INFO - 'tsvg_static']}, 09:23:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:32 INFO - 'tsvgr_opacity', 09:23:32 INFO - 'tart', 09:23:32 INFO - 'tscrollx', 09:23:32 INFO - 'cart', 09:23:32 INFO - 'tsvg_static']}, 09:23:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'talos_options': ['--disable-e10s'], 09:23:32 INFO - 'tests': ['tp5o']}, 09:23:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'talos_options': ['--disable-e10s', 09:23:32 INFO - '--xperf_path', 09:23:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:32 INFO - 'tests': ['tp5n']}, 09:23:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:32 INFO - 'talos_options': ['--xperf_path', 09:23:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:32 INFO - 'tests': ['tp5n']}}, 09:23:32 INFO - 'talos.zip': {'path': '', 09:23:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:32 INFO - Running post-action listener: _resource_record_post_action 09:23:32 INFO - [mozharness: 2017-05-22 16:23:32.747196Z] Finished populate-webroot step (success) 09:23:32 INFO - [mozharness: 2017-05-22 16:23:32.747286Z] Running create-virtualenv step. 09:23:32 INFO - Running pre-action listener: _resource_record_pre_action 09:23:32 INFO - Running main action method: create_virtualenv 09:23:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:32 INFO - Using real prefix '/tools/python27' 09:23:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:36 INFO - Installing pip.................done. 09:23:36 INFO - Return code: 0 09:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:36 INFO - Reading from file tmpfile_stdout 09:23:36 INFO - Output received: 09:23:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:23:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:36 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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:23:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:36 INFO - 'HOME': '/Users/cltbld', 09:23:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:36 INFO - 'LOGNAME': 'cltbld', 09:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:36 INFO - 'MOZ_NO_REMOTE': '1', 09:23:36 INFO - 'NO_EM_RESTART': '1', 09:23:36 INFO - 'PAGER': '/bin/cat', 09:23:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:36 INFO - 'PWD': '/builds/slave/test', 09:23:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:36 INFO - 'SHELL': '/bin/bash', 09:23:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:23:36 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:23:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:36 INFO - 'USER': 'cltbld', 09:23:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:36 INFO - 'XPC_FLAGS': '0x0', 09:23:36 INFO - 'XPC_SERVICE_NAME': '0', 09:23:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:23:36 INFO - Cleaning up... 09:23:37 INFO - Return code: 0 09:23:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:37 INFO - 'HOME': '/Users/cltbld', 09:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:37 INFO - 'LOGNAME': 'cltbld', 09:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:37 INFO - 'MOZ_NO_REMOTE': '1', 09:23:37 INFO - 'NO_EM_RESTART': '1', 09:23:37 INFO - 'PAGER': '/bin/cat', 09:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:37 INFO - 'PWD': '/builds/slave/test', 09:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:37 INFO - 'SHELL': '/bin/bash', 09:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:23:37 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:37 INFO - 'USER': 'cltbld', 09:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:37 INFO - 'XPC_FLAGS': '0x0', 09:23:37 INFO - 'XPC_SERVICE_NAME': '0', 09:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:37 INFO - Downloading/unpacking psutil>=3.1.1 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:10 INFO - Installing collected packages: psutil 09:26:10 INFO - Running setup.py install for psutil 09:26:10 INFO - building 'psutil._psutil_osx' extension 09:26:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:26:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:26:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:26:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:26:10 INFO - building 'psutil._psutil_posix' extension 09:26:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:26:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:26:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:26:10 INFO - ^ 09:26:11 INFO - 1 warning generated. 09:26:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:26:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:11 INFO - Successfully installed psutil 09:26:11 INFO - Cleaning up... 09:26:11 INFO - Return code: 0 09:26:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:11 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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:11 INFO - 'HOME': '/Users/cltbld', 09:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:11 INFO - 'LOGNAME': 'cltbld', 09:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:11 INFO - 'MOZ_NO_REMOTE': '1', 09:26:11 INFO - 'NO_EM_RESTART': '1', 09:26:11 INFO - 'PAGER': '/bin/cat', 09:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:11 INFO - 'PWD': '/builds/slave/test', 09:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:11 INFO - 'SHELL': '/bin/bash', 09:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:26:11 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:11 INFO - 'USER': 'cltbld', 09:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:11 INFO - 'XPC_FLAGS': '0x0', 09:26:11 INFO - 'XPC_SERVICE_NAME': '0', 09:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:28:44 INFO - Installing collected packages: mozsystemmonitor 09:28:44 INFO - Running setup.py install for mozsystemmonitor 09:28:44 INFO - Successfully installed mozsystemmonitor 09:28:44 INFO - Cleaning up... 09:28:44 INFO - Return code: 0 09:28:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:28:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:28:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:28:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:28:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:28:46 INFO - 'HOME': '/Users/cltbld', 09:28:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:28:46 INFO - 'LOGNAME': 'cltbld', 09:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:28:46 INFO - 'MOZ_NO_REMOTE': '1', 09:28:46 INFO - 'NO_EM_RESTART': '1', 09:28:46 INFO - 'PAGER': '/bin/cat', 09:28:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:28:46 INFO - 'PWD': '/builds/slave/test', 09:28:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:28:46 INFO - 'SHELL': '/bin/bash', 09:28:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:28:46 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:28:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:28:46 INFO - 'USER': 'cltbld', 09:28:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:28:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:28:46 INFO - 'XPC_FLAGS': '0x0', 09:28:46 INFO - 'XPC_SERVICE_NAME': '0', 09:28:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:28:46 INFO - Downloading/unpacking jsonschema==2.5.1 09:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:28:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:49 INFO - warning: no files found matching '*.txt' 09:33:49 INFO - no previously-included directories found matching 'build' 09:33:49 INFO - no previously-included directories found matching 'dist' 09:33:49 INFO - no previously-included directories found matching '.git*' 09:33:49 INFO - Installing collected packages: jsonschema, functools32 09:33:49 INFO - Running setup.py install for functools32 09:33:49 INFO - warning: no files found matching '*.txt' 09:33:49 INFO - no previously-included directories found matching 'build' 09:33:49 INFO - no previously-included directories found matching 'dist' 09:33:49 INFO - no previously-included directories found matching '.git*' 09:33:49 INFO - Successfully installed jsonschema functools32 09:33:49 INFO - Cleaning up... 09:33:49 INFO - Return code: 0 09:33:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:51 INFO - 'HOME': '/Users/cltbld', 09:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PAGER': '/bin/cat', 09:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:33:51 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - 'XPC_FLAGS': '0x0', 09:33:51 INFO - 'XPC_SERVICE_NAME': '0', 09:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:51 INFO - Cleaning up... 09:33:51 INFO - Return code: 0 09:33:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:51 INFO - 'HOME': '/Users/cltbld', 09:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PAGER': '/bin/cat', 09:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:33:51 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - 'XPC_FLAGS': '0x0', 09:33:51 INFO - 'XPC_SERVICE_NAME': '0', 09:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:24 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:25 INFO - Downloading docopt-0.6.1.tar.gz 09:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:41:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:41:26 INFO - Running setup.py install for blobuploader 09:41:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:41:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:41:26 INFO - Running setup.py install for requests 09:41:26 INFO - Running setup.py install for docopt 09:41:26 INFO - Successfully installed blobuploader requests docopt 09:41:26 INFO - Cleaning up... 09:41:26 INFO - Return code: 0 09:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:27 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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:27 INFO - 'HOME': '/Users/cltbld', 09:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:27 INFO - 'LOGNAME': 'cltbld', 09:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:27 INFO - 'MOZ_NO_REMOTE': '1', 09:41:27 INFO - 'NO_EM_RESTART': '1', 09:41:27 INFO - 'PAGER': '/bin/cat', 09:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:27 INFO - 'PWD': '/builds/slave/test', 09:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:27 INFO - 'SHELL': '/bin/bash', 09:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:41:27 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:27 INFO - 'USER': 'cltbld', 09:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:27 INFO - 'XPC_FLAGS': '0x0', 09:41:27 INFO - 'XPC_SERVICE_NAME': '0', 09:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-841iCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-OwFITe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-B9nvcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-ZVppsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-XYBPx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-ksT7wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-e_MvBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:28 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-sDvBHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-ACGVMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-7iLPIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-0AKSZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-FYa71D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-wvdKbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-Y_1gbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-8MKD3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-MUX8i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:29 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-Tc5OQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:41:29 INFO - Running setup.py install for manifestparser 09:41:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:41:30 INFO - Running setup.py install for mozcrash 09:41:30 INFO - Running setup.py install for mozdebug 09:41:30 INFO - Running setup.py install for mozdevice 09:41:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:41:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:41:30 INFO - Running setup.py install for mozfile 09:41:30 INFO - Running setup.py install for mozhttpd 09:41:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:41:30 INFO - Running setup.py install for mozinfo 09:41:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Running setup.py install for mozInstall 09:41:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Running setup.py install for mozleak 09:41:31 INFO - Running setup.py install for mozlog 09:41:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Running setup.py install for moznetwork 09:41:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Running setup.py install for mozprocess 09:41:31 INFO - Running setup.py install for mozprofile 09:41:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:41:31 INFO - Running setup.py install for mozrunner 09:41:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:41:32 INFO - Running setup.py install for mozscreenshot 09:41:32 INFO - Running setup.py install for moztest 09:41:32 INFO - Running setup.py install for mozversion 09:41:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:41:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:41:32 INFO - Cleaning up... 09:41:32 INFO - Return code: 0 09:41:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:32 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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:41:32 INFO - 'HOME': '/Users/cltbld', 09:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:41:32 INFO - 'LOGNAME': 'cltbld', 09:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:32 INFO - 'MOZ_NO_REMOTE': '1', 09:41:32 INFO - 'NO_EM_RESTART': '1', 09:41:32 INFO - 'PAGER': '/bin/cat', 09:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:32 INFO - 'PWD': '/builds/slave/test', 09:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:41:32 INFO - 'SHELL': '/bin/bash', 09:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:41:32 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:41:32 INFO - 'USER': 'cltbld', 09:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:32 INFO - 'XPC_FLAGS': '0x0', 09:41:32 INFO - 'XPC_SERVICE_NAME': '0', 09:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:32 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-3S5PvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:32 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-Fx6VyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-Aqga1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-uYotE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-7Dqhln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-4JPrTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-gxjcET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-PcT8kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-aD2NOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-W7FBHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:33 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-VCS1p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:34 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-BBWG7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:34 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-PZRMgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:34 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-UhOPF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:34 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-1V6YAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:34 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-0OTkZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:34 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-qkdkUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:41:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:07 INFO - Downloading blessings-1.6.tar.gz 09:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:07 INFO - Installing collected packages: blessings 09:44:07 INFO - Running setup.py install for blessings 09:44:07 INFO - Successfully installed blessings 09:44:07 INFO - Cleaning up... 09:44:07 INFO - Return code: 0 09:44:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:07 INFO - Reading from file tmpfile_stdout 09:44:07 INFO - Current package versions: 09:44:07 INFO - blessings == 1.6 09:44:07 INFO - blobuploader == 1.2.4 09:44:07 INFO - docopt == 0.6.1 09:44:07 INFO - functools32 == 3.2.3-2 09:44:07 INFO - jsonschema == 2.5.1 09:44:07 INFO - manifestparser == 1.1 09:44:07 INFO - mozInstall == 1.12 09:44:07 INFO - mozcrash == 1.0 09:44:07 INFO - mozdebug == 0.1 09:44:07 INFO - mozdevice == 0.49 09:44:07 INFO - mozfile == 1.2 09:44:07 INFO - mozhttpd == 0.7 09:44:07 INFO - mozinfo == 0.9 09:44:07 INFO - mozleak == 0.1 09:44:07 INFO - mozlog == 3.4 09:44:07 INFO - moznetwork == 0.27 09:44:07 INFO - mozprocess == 0.25 09:44:07 INFO - mozprofile == 0.28 09:44:07 INFO - mozrunner == 6.13 09:44:07 INFO - mozscreenshot == 0.1 09:44:07 INFO - mozsystemmonitor == 0.3 09:44:07 INFO - moztest == 0.8 09:44:07 INFO - mozversion == 1.4 09:44:07 INFO - psutil == 3.1.1 09:44:07 INFO - requests == 1.2.3 09:44:07 INFO - wsgiref == 0.1.2 09:44:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:08 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 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:44:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:44:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:09 INFO - 'HOME': '/Users/cltbld', 09:44:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:09 INFO - 'LOGNAME': 'cltbld', 09:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:09 INFO - 'MOZ_NO_REMOTE': '1', 09:44:09 INFO - 'NO_EM_RESTART': '1', 09:44:09 INFO - 'PAGER': '/bin/cat', 09:44:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:09 INFO - 'PWD': '/builds/slave/test', 09:44:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:09 INFO - 'SHELL': '/bin/bash', 09:44:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:44:09 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:44:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:09 INFO - 'USER': 'cltbld', 09:44:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:09 INFO - 'XPC_FLAGS': '0x0', 09:44:09 INFO - 'XPC_SERVICE_NAME': '0', 09:44:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:44:09 INFO - Cleaning up... 09:44:09 INFO - Return code: 0 09:44:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87615bc320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, '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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:44:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:44:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:09 INFO - 'HOME': '/Users/cltbld', 09:44:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:09 INFO - 'LOGNAME': 'cltbld', 09:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:09 INFO - 'MOZ_NO_REMOTE': '1', 09:44:09 INFO - 'NO_EM_RESTART': '1', 09:44:09 INFO - 'PAGER': '/bin/cat', 09:44:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:09 INFO - 'PWD': '/builds/slave/test', 09:44:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:09 INFO - 'SHELL': '/bin/bash', 09:44:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:44:09 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:44:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:09 INFO - 'USER': 'cltbld', 09:44:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:09 INFO - 'XPC_FLAGS': '0x0', 09:44:09 INFO - 'XPC_SERVICE_NAME': '0', 09:44:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:44:09 INFO - Cleaning up... 09:44:09 INFO - Return code: 0 09:44:09 INFO - Running post-action listener: _resource_record_post_action 09:44:09 INFO - Running post-action listener: _start_resource_monitoring 09:44:09 INFO - Starting resource monitoring. 09:44:09 INFO - [mozharness: 2017-05-22 16:44:09.571880Z] Finished create-virtualenv step (success) 09:44:09 INFO - [mozharness: 2017-05-22 16:44:09.572807Z] Running install step. 09:44:09 INFO - Running pre-action listener: _resource_record_pre_action 09:44:09 INFO - Running main action method: install 09:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:09 INFO - Reading from file tmpfile_stdout 09:44:09 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:09 INFO - Reading from file tmpfile_stdout 09:44:09 INFO - Output received: 09:44:09 INFO - Usage: mozinstall [options] installer 09:44:09 INFO - Options: 09:44:09 INFO - -h, --help show this help message and exit 09:44:09 INFO - -d DEST, --destination=DEST 09:44:09 INFO - Directory to install application into. [default: 09:44:09 INFO - "/builds/slave/test"] 09:44:09 INFO - --app=APP Application being installed. [default: firefox] 09:44:09 INFO - mkdir: /builds/slave/test/build/application 09:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:44:30 INFO - Reading from file tmpfile_stdout 09:44:30 INFO - Output received: 09:44:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:44:30 INFO - Running post-action listener: _resource_record_post_action 09:44:30 INFO - [mozharness: 2017-05-22 16:44:30.153097Z] Finished install step (success) 09:44:30 INFO - [mozharness: 2017-05-22 16:44:30.153278Z] Running run-tests step. 09:44:30 INFO - Running pre-action listener: _resource_record_pre_action 09:44:30 INFO - Running main action method: run_tests 09:44:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:30 INFO - 2017-05-22 09:44:30.167 screenresolution[1630:9555] starting screenresolution argv=screenresolution get 09:44:30 INFO - 2017-05-22 09:44:30.170 screenresolution[1630:9555] Display 0: 1600x1200x32@60 09:44:30 INFO - 2017-05-22 09:44:30.176 screenresolution[1631:9558] starting screenresolution argv=screenresolution list 09:44:30 INFO - Available Modes on Display 0 09:44:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:30 INFO - Intel Iris: 09:44:30 INFO - Chipset Model: Intel Iris 09:44:30 INFO - Type: GPU 09:44:30 INFO - Bus: Built-In 09:44:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:30 INFO - Vendor: Intel (0x8086) 09:44:30 INFO - Device ID: 0x0a2e 09:44:30 INFO - Revision ID: 0x0009 09:44:30 INFO - Displays: 09:44:30 INFO - Display: 09:44:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:30 INFO - Display Serial Number: 1600x1200 60 09:44:30 INFO - Main Display: Yes 09:44:30 INFO - Mirror: Off 09:44:30 INFO - Online: Yes 09:44:30 INFO - Rotation: Supported 09:44:30 INFO - Return code: 0 09:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:30 INFO - Python 2.7.3 09:44:30 INFO - Return code: 0 09:44:30 INFO - grabbing minidump binary from tooltool 09:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:30 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 0x106ec0d30>, '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 0x106de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106eb5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:44:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:44:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:44:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:30 INFO - Return code: 0 09:44:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:44:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:30 INFO - ENV: RUST_BACKTRACE is now 1 09:44:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:44:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Jamun --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0372 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:44:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m2ZYw5Ypn/Render', 09:44:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:30 INFO - 'HOME': '/Users/cltbld', 09:44:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:30 INFO - 'LOGNAME': 'cltbld', 09:44:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:30 INFO - 'MOZ_NO_REMOTE': '1', 09:44:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:30 INFO - 'NO_EM_RESTART': '1', 09:44:30 INFO - 'PAGER': '/bin/cat', 09:44:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:30 INFO - 'PWD': '/builds/slave/test', 09:44:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:30 INFO - 'RUST_BACKTRACE': '1', 09:44:30 INFO - 'SHELL': '/bin/bash', 09:44:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cRwdIHNZMj/Listeners', 09:44:30 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 09:44:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:30 INFO - 'USER': 'cltbld', 09:44:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:30 INFO - 'XPC_FLAGS': '0x0', 09:44:30 INFO - 'XPC_SERVICE_NAME': '0', 09:44:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:44:30 INFO - mozversion application_buildid: 20170522053521 09:44:30 INFO - mozversion application_changeset: 44293893aae54b139118c47c3f771a6b71748d3b 09:44:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:44:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:30 INFO - mozversion application_name: Firefox 09:44:30 INFO - mozversion application_remotingname: firefox-dev 09:44:30 INFO - mozversion application_repository: https://hg.mozilla.org/projects/jamun 09:44:30 INFO - mozversion application_vendor: Mozilla 09:44:30 INFO - mozversion application_version: 54.0 09:44:30 INFO - mozversion platform_buildid: 20170522053521 09:44:30 INFO - mozversion platform_changeset: 44293893aae54b139118c47c3f771a6b71748d3b 09:44:30 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/jamun 09:44:30 INFO - mozversion platform_version: 54.0 09:44:30 INFO - using testdate: 1495471470 09:44:30 INFO - actual date: 1495471470 09:44:30 INFO - starting webserver on 'localhost:49248' 09:44:30 INFO - SUITE-START | Running 2 tests 09:44:30 INFO - TEST-START | dromaeo_css 09:44:30 INFO - operating with platform_type : mac_ 09:44:30 INFO - Initialising browser for dromaeo_css test... 09:44:30 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpumZINQ/profile http://localhost:49248/getInfo.html) 09:44:33 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 09:44:33 INFO - PROCESS | 1641 | colorDepth:24 09:44:33 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 09:44:33 INFO - PROCESS | 1641 | __metrics 09:44:33 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:44:33 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:34 INFO - TEST-INFO | 1641: exit 0 09:44:34 INFO - Browser initialized. 09:44:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:44:34 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpumZINQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:46 INFO - PROCESS | 1648 | RSS: Main: 193523712 09:44:46 INFO - PROCESS | 1648 | 09:47:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 09:47:53 INFO - PROCESS | 1648 | RSS: Main: 417116160 09:47:53 INFO - PROCESS | 1648 | 09:50:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 09:50:56 INFO - PROCESS | 1648 | RSS: Main: 331292672 09:50:56 INFO - PROCESS | 1648 | 09:53:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 09:53:59 INFO - PROCESS | 1648 | RSS: Main: 316858368 09:53:59 INFO - PROCESS | 1648 | 09:57:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 09:57:02 INFO - PROCESS | 1648 | RSS: Main: 298840064 09:57:02 INFO - PROCESS | 1648 | 10:00:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:00:06 INFO - PROCESS | 1648 | RSS: Main: 296681472 10:00:06 INFO - PROCESS | 1648 | 10:03:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:03:10 INFO - PROCESS | 1648 | RSS: Main: 354045952 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | __start_tp_report 10:03:10 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 10:03:10 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 10:03:10 INFO - PROCESS | 1648 | |i|pagename|runs| 10:03:10 INFO - PROCESS | 1648 | |0;dojo.html;3264.6735326467356;3405.063607507935;3426.434638284683;3456.9827150864244;3463.35927853347;5979.850503737409;6006.309274433442;6013.609115407507;6036.305824830135;6046.183765191698;6005.909911351322;6072.8178154655325;6076.483498902588;6086.391360863922;6094.329623741385;5400.29796126504;5440.238366628655;5446.809361672343;5451.536619387357;5583.804566840141;5319.6808191508635;5324.307839980797;5389.595780316472;5402.189671549259;5496.642718223303;5430.755615997289;5433.239346491494;5441.183822426648;5441.891162176754;5471.151971444432;5438.374586922476;5439.5920305977015;5441.129419292934;5447.291852059247;5456.890862182754;5255.60582956276;5383.16560933056;5392.757325920304;5394.352677678665;5428.131498960148;6062.272527296708;6062.42406971337;6068.180795592582;6069.696515174268;6077.453029227391;6288.151099601587;6309.621422714652;6312;6326.051092336141;6326.240851097852;6252.406021427957;6254;6296.527760417987;6346.904796428057;6359;6084.878302433971;6135.171751813537;6139.416755408229;6163.537734669918;6164.445199932027;6201.596896201732;6286.591371560834;6554.344565543408;6555.93444065558;6557.475401967831;6204.81385558434;6261.624302541771;6275.058741188858;6290.119383286344;6303.6532990685955;6331.461825744863;6375.330590288046;6387.616742995435;6387.904181437282;6413;6202.72087756052;6323.5573509854785;6331.113644089831;6331.366863313632;6331.778387756406;6217.285012223652;6231.034189700513;6244.843878903063;6320.968395158086;6358.300586935434;5149.613778966593;5164.096283150434;5170.939957308743;5183.377994640592;5200.011997720497;3941.2708648900043;4581.40441742578;4598.931016034762;4602.125596136723;4638.860834174912;5808.273965754281;5868.706564671835;5926.348101708809;6014.849628759229;6098.817035488943;6249.25008998923;6313.842153946188;6351.110844481776;6374.968125159345;6380.138681277968;5955.285365756137;5999.430054144849;6019.157317975487;6037.335893051761;6046.274447066292;5497.038018346853;5640.097584386478;5641.548676105902;5660.15097735343;5666.320041594952;6304.873902522016;6414.102025716404;6469.061986011908;6557.573757705733;6628;6359.586626869239;6397;6413.0701048348665;6420.3258657842125;6420.550561460653;6520.576162549419;6606.108175396452;6607.80176594703;6631.104800851823;6639.103720997604;6225.906611400923;6307.653079080695;6323.905141422791;6342.143810585512;6348.619082855043;6268.655223962726;6281.905771413341;6282.685865706605;6291.245050593958;6324.715387807468;6279.748810047547;6282.685865706788;6300.842478938063;6306.117143599808;6318.873622527615;6291.213598300213;6305.6216627000695;6307.085472606354;6310.652914089769;6311.526635502448;5328.17413300939;5858.297004359504;6064.696765161636;6300.936990630035;6309.936900630935;6175.84560385994;6199.380061993765;6216.720247588779;6296.779612713533;6313.779017734358;6149.831532008904;6152.446279834837;6159.983602705683;6267.655278959701;6267.686615669107 10:03:10 INFO - PROCESS | 1648 | |1;ext.html;801.8356236971422;813.0649752784298;888.6889588643976;895.1540793949716;984.1831280037561;28311.858440707794;38386.42420363693;39513.20973580526;39653.008674783145;39697.404538931936;38191.04522386935;38337.84986450404;38458.23083538328;38522.03694907622;38561.614383856155;7465.738699145531;7699.769006929801;7930.444868859182;8051.677932882678;11498.022668073181;11354.886451135466;11475.827862582068;11506.712332191679;11511.194216404854;11514.539418423254;9819.772528433945;11494.023008044327;11536.307821530734;11539.65381038566;11540.65378038656;11461.197716159872;11476.770464590662;11487.712807179803;11493.367864767435;11514.309141451498;11193.608223712132;11238.381888996102;11239.381833999127;11247.887521124847;11251.887481125166;38962.61037389618;39060.80469597662;39121.21757564861;39134.804325978184;39135.41296880549;3829.2915810574855;3882.010087427716;3885.5725870154542;3893.1045859452483;3910.9413358799643;26929.596056059174;27570.862145689345;28685.28286792826;28787;29170.15591976728;3073.3699591583672;3145.276586385144;3212.1166679163416;3303.702666760003;3304.4052070627276;346235;347193;347487;347545;347779;51663.22505162426;52144;52272;52364;52386;53130.21828035495;53195;53212.46787532153;53235.73382133142;53369.46630533723;14585.270736463346;14993.32530036151;15047.796176305868;15052.698946021237;15080.944333896521;12962.22226666403;12967.675808104872;12972.09195356335;12978.415971281314;12993.090483666241;11333.923277288644;11777.352245626573;11806.527738890349;11841.111916606289;11921.986631136451;5289.312389389354;5354.170103633943;5357.892842143136;5361.329833770778;5374.838754837361;981.4896253947907;1098.9065879449838;1120.464963000678;1164.6855349055706;1217.713837248246;23258.65112023321;24497.690445055563;26224.21327360182;26227.606585901227;26298.737012630012;1263.6731431996368;1266.65167079054;1270.993645031769;1314.3559655768604;1315.8092076648832;12720.427580758704;13435.261060641564;13468.461261549428;13772.65568360799;13773.724525509433;448224;448558;449296;450235.7488212538;451799;54320.72839635856;54347.45652543503;54373.45626543763;54443.45556544463;54464.45535544673;1257.9119461637597;1275.0118658040094;1421.8791402730676;1480.7408703477063;1483.5252719129776;18730.906345468185;19414.805851941866;26707.33231669224;27243.318917027234;27251.72748272492;42859;43234.35148472838;43257.13485730205;43305.35041974436;43364.78317608392;458985;460218;460851;461408;461525;22787.088516459156;23339;26926.326841828326;27922.720772792825;28099.859500702365;36516.63483365239;36605.450918235714;36620.901372958855;36701.71543995947;36815.26369472542;24814.37964050913;25140.12009579656;25624.487510249317;25922.87038564795;27033.45933081288;25994.35014124662;26729.19812405631;27043.594346084432;27129.86435067812;27207.72792272131;25690.229293121236;29653.406931861675;30544.541831872095;30749.385012300078;30773.23066923345;26724;27029.324266892698;27066.594001090394;27187.32031699144;27540.862295688392;17181.74227386615;18553.907230463763;21032.57934841264;22118.778812211673;22154.335369938926 10:03:10 INFO - PROCESS | 1648 | |2;jquery.html;418.94134821125067;429.2680978930922;429.66116900814217;436.0929267124381;440.376866733572;20743.170273189073;21321.786782132174;21850.344489665316;22204;22568.210112646062;22270.77510736909;22605.54788904221;22942.541149177006;23556.5288694226;23902.40243993901;5230.450802665722;6598.802035938929;6800.081988931505;6835.3164683531495;6898.310168983112;6742.258351581322;6810.659467026654;6843;6845.212800527928;6878.312168783106;6476.611403315793;6774.220964589062;6850.1779786425695;6857.965710171442;6865.691043903036;6451.612903225775;6694.56485328457;6725.630090345029;6747.460203183734;6781.457483401341;6586.736530538773;6591.044298576728;6597.505187110986;6601.3728695773825;6602.636854972975;26731.19806405811;26745.796439160284;26846.791894364604;26853.73146268532;27131;2780.263230243987;2803.1450407625666;2974.434857377113;2980.925476863096;2997.310618557722;15813.209339532978;16133;16507.752383714254;17697.38059167923;17810;2037.4295197344768;2062.2163577840474;2066.71066050753;2085.353540402465;2094.099537199019;103762;107343.92656073495;124870.75129248682;129708.7029129706;132269.33865330613;20917.26789562358;21386.893065534572;21468.355949321547;21732.78267217339;21744;35182;35670.64329356673;35951.820240898625;35960.46059309113;36019.838809671506;10740.248182627141;10991.670249892515;11160.0513956313;11172.162087843444;11416.257943233662;9081.636734530677;9090.045545217788;9098.453262945315;9290.210332121711;9304.8604270936;8466.661333546712;10230.567720519133;10346.430946297874;10378.532966016548;10469.738256543495;3553.680168784822;3659.5059666945153;4259.701820872509;4281.431141315186;4300.65594752419;1013.6857574152036;1026.9127124194526;1027.3989716016215;1028.5628607841638;1066.989330106689;21928;22465.213717520135;22478;22764.772352276595;22771.31686049421;891.6745387933487;1020.454057079459;1042.135027926819;1049.6483677967813;1057.7831544533353;11152.275102118336;11678;11757.529698812123;11762.470688819023;11792.941035294769;582951;773454;782979;783067;803919;115895.6820863578;130674;132562;134402;159367.20316398575;1257.861635220125;1295.4688577683105;1315.7302752935625;1319.4788058716754;1319.4788058716945;18503.722444163617;20025.899870500554;20042.298519551747;20091.497712557302;20118.69821952701;60460;64255.67872160609;64620.353796463314;64807;65031.67484162549;90561;90887;92967;93273.53811695184;95070.52464737909;11100.888991109985;11169.162312826407;11256.662300131009;11716.472758726048;11761.353125578175;12329.383530823603;12359.75280494403;12552.937235313764;12616.621501354974;12741.80887286673;10869.076128529163;10916.216364826918;10923.071538919281;10983.231173817756;11076.446177691245;9914.801703965735;9996.800063998533;10167.084962353423;10232.334898231591;10334.069933706003;10865.891341086804;11055.778884422427;11102.167337449562;11165.274257173258;11342.262752921364;9612.807743845224;11204.383758893338;11322.60370887015;11377.4880130396;11745.47145378443;9235.49204793716;10460.320079194827;10719.624813131502;10759.3544387337;10873.945630272114 10:03:10 INFO - PROCESS | 1648 | |3;mootools.html;1353.3503918119309;1575.2517554161775;1599.880008999325;1605.237512181713;1613.5240104169268;9253.213476854467;9662;10775.83836242456;11068.169887258447;11225.214235003554;10827.6751697449;10980.890191098086;10982.231243812936;10986.450677466115;10988;2355.2698663414353;2402.315340128064;2403.807695384374;2404.4710163763943;2408.8313818032743;1709.025855262501;2119.5231073008604;2362.8582285062953;2432.3797431654903;2453.3621258472836;2379.095943541452;2404.675368825204;2405.3265085775924;2410.8794560272004;2410.915617953372;2352.1532248390567;2390.008146619151;2395.4131237846664;2395.748446413136;2397.29279862441;2270.194081101202;2331.63859601762;2340.508493216427;2391.4619210677633;2394.856308621488;11114.444277786079;11254.774904501946;11264.605738799184;11266.380349080797;11323.830142547786;5797.768089276424;5980.790672326491;5983.760649574012;5984.3417224105315;6002;2828.3636181859124;3496.968394323655;3549.1836877518317;3552.342816578941;3552.5559305086863;1064.1699474409972;1143.805553055974;1186.590626233948;1194.247623996885;1245.103525461666;15306.234688265542;15348.386064557404;15547.611309717235;15573.844261557353;15594.610134746608;4759.4551012534175;4782.856514304576;4795.856124316276;4880.389951256093;4903.01939612079;12966.157199782172;12970.897473714651;12972.416241269166;12997.610071697864;13000.08999370035;5896.7641294348605;5993.0710739835395;6008.429199226067;6011.068284415923;6011.158437818709;4509.098180363941;5149.382074151051;5267.657602255841;5322.866928326823;5340.145576707708;3024.742896853792;3604.729645276562;3927.430522574211;4040.1919616076902;4061.614146656063;1056.4717641179411;1079.433297518809;1080.152080616712;1098.319042193845;1101.2841652925501;935.6397786852111;955.1594596754811;958.6836344006462;960.2558017536466;1004.4481276427937;5542.722863856791;5687.175359572839;6689.565178263398;6719.966400167968;6871.4502839772695;1027.6300531808542;1032.6798692405378;1038.8649475568127;1043.9269251152346;1044.1698849414581;4233.640140588023;4250.766207858535;4294.806733696991;4369.257226271541;4399.450068741407;13464;14061.929690351482;14071.2964351782;14089.85910140906;14092.788608170886;13513.189208647513;13845.376958036912;13991.090579112326;14032.438702451991;14171.433142674383;9979.151772099307;10220.897791022144;10279.53742081623;10380.117689996436;10393.584256629802;5747.942520574741;5891.823245302648;5985.521158307412;6010.1585777991995;6085.588545711633;9225;9286.62853485853;9292.349535532448;9406.294527910297;9453.716388508356;9390.483523406278;9451.810963780823;9564.234861211226;9597.712068637951;9609.615615375586;9169.40398874071;9258.35191536586;9274.582643780912;9406;9413.905860941302;9029.593668285075;9241.168294853227;9336.29977751685;9416.387934784218;10008.549615267184;8660;8797.340199484936;8934.329925255503;9000.23498002651;9002;7575.46971711997;8714.825703486022;8715.95408550978;8743.475391476532;8823.867641985247;7770.14528401864;7947.801304967422;7951.204879512003;7955;7957.880631790412;5914.408559144051;5939.940600593939;5941.881162376641;6118.510519158368;6156.692165391623;5953.404659534012;5956.792420070835;6100.481459076028;6209.161763161916;6288.748450061947 10:03:10 INFO - PROCESS | 1648 | |4;prototype.html;327.31754292300553;379.37782037458555;387.9010852232682;388.28167889404585;390.2779857264061;5067.366579177603;5083.491650834914;5165;5174.508421699942;5185.32955527903;4851.1753001989655;4997.925031124536;5060.746962651871;5073.239014147871;5082.695038297705;3505.754597178192;3945.9013524661827;3988.6210809973004;4041.939370909439;4044.6562042226446;3586.1751797086686;3951.940720889189;3993.620606042436;4042.1915616876595;4044.5550989391145;4022.658074063708;4037.1925614876995;4043.818028188724;4045.231406032859;4051.9942628398985;3171.57183780189;3609.628341230342;3809.29528037314;4027.3757567576927;4081.9795051237043;3195.8561864716144;3543.9114022149392;3566.7146628269675;3568.37553428149;3586.22896077342;3955.881323560298;4058.736182148151;5007.973365460072;5012.774425150877;5017.448080711119;4186.267403204427;4316.892077698051;4642.51253618372;4645.256758918556;4657.767111644438;5094.949050509485;5314.468553144693;5321.281626980347;5321.620770810525;5417.377001644822;3713.1088538750773;4195.643370313527;4296.957030429687;4300.61294483498;4336.82652693895;5194.324737784102;5472.72636368184;5489.4236105209175;5600.803971861006;5801.3328467225965;3079.4610943085318;3571.0181998031417;3596.8021758803516;3933.193695292458;4252.4046633471335;4077.368007958771;4347.7173983690955;4429.2913133899065;4563.794629241625;4570.771461426915;4430.712003719812;4431.7340959542535;4810.921010553248;4812.25410061441;4885.487023862514;4451;5069.594432445396;5321.388040375329;5323.817234933658;5423.864403389868;1342.5232244530937;1351.4999450203488;1378.5864240727742;1391.7007843313534;1485.6657252118187;1034.5965073621294;1064.5209655654987;1093.4478088565224;1140.2816225777708;1140.8021577343923;4236.851710190129;4751.382320298339;4997.9750101249265;5014.448410674823;5074.289599456005;5550.306211723535;5562.499375056183;5612.828751755245;5627.774889004476;5639.351474580476;4537.818487260539;4754.144254034307;4818.831340903052;5010.2735103409805;5021.748912554358;2491.638712386694;2656.5749480083095;2761.351082495612;2877.0937154796593;2936.2219011961847;5414.8917021659345;5503.394626591072;5826.184334193216;5827.562932780059;5842.649441033552;5181.663191892515;5543.223948647193;5607.551395888319;5619.8595035124445;5710.371859095496;4713.599344055794;5182.507661772125;5429.778299882495;5503.669779813224;5605.719714014202;4364.388985541963;5411.594130440154;5426.728663566727;5545.417731138334;5581.860453488695;5200.921986170286;5324;5531.502164805026;5541.251930989426;5563.749631266522;5087.734195108045;5111.897762044664;5155.226715992631;5658.03813351723;5800.59395842287;3956.2878681836396;4210.705250632426;4234.830606775695;4363.890902727458;4465.682623626103;4837.661363704507;5095.77069031887;5519.944800551943;5646.407127251579;5706.4864162225595;5122.846314610568;5309.442508536703;5344.85085706575;5345.973270133624;5374.355077390738;5229.973850130725;5345.973270133624;5389.676619402849;5425.457454254543;5448.373437054631;5105.974470127626;5130.510803047334;5240.842774716764;5242.16125419931;5335.839924802262;4854.907645779671;4950.752462376795;5372.516473517402;5392;5428.67427954324;4938.074151081153;5219.8434046978655;5252.369715634149;5352.330958630171;5361.35663720356 10:03:10 INFO - PROCESS | 1648 | |5;yui.html;724.3480867219505;747.6411322565172;773.3387953299929;845.1041895590674;847.8685803700427;15179.620509487268;15908.443204487845;15948.28232729527;16037.278322475488;16046.438374656875;14671.77992330116;16694.499165025038;16874.83125168748;17186.226619802106;17494.21276042578;953.5232383808078;977.3061126600122;980.5734505490099;982.0474140084107;983.4885859353168;840.2983508770154;955.7801705607715;975.1418751498671;979.647326962293;980.5293459139617;1041.1878734586996;1044.4621020174616;1045.9424731639756;1046.8377401502742;1047.2983101322131;1033.3593172233188;1038.3614077342418;1039.2569312941207;1040.8646875906122;1040.8907064758205;774.2025713515088;774.9263819937097;775.2015424113173;775.3061010395664;777.7044723005279;15923.044617322998;16241.350345986146;16300.103494307808;16762.916185419115;17002.40491582801;14199.858001419956;14267.429302827875;14427;14490.492832750802;14505.564833055025;11541.192116551845;11739.647810565697;11762.823557646641;11829.585964491287;12434.875651243552;3525.9118522036897;3708.1100535871196;3768.0956570423177;3791.6018818023986;3895.8052097395303;86484;104508;114634.85365146326;114708.42645786802;118851.21723174246;10098.091171794427;10553.63062292816;10620.893791062144;11015.889841101647;11257.662270131908;22924.656130158062;23242.302730918098;23460.413489662555;23468.882655586614;23480.64779028316;7869.803254918558;7872.44892857506;7904.525728456311;7970.84058318842;8136.877946830802;4330.437043184366;4371.956280437218;4391.231534481453;4430.82276708928;4569.360289559464;3409.8636054558037;3470.878519251814;3492.9825350873593;3493.3886569850174;3496.7027802636553;509.76507086013333;629.7827249598881;632.3044650883991;635.3773302163813;637.178040327981;666.6366830077619;683.2211279141783;700.425650966213;704.9365557099783;728.2104992737711;10117.645882394081;10239.078482936571;10304.072633463024;10418.895811041944;10445.9477702611;658.4777776127465;703.6165289917008;704.7709494414336;706.3713295167305;711.4699548836151;4706.247000479907;4971.701697898137;5026.145555255615;5031.471695471922;5038.118329292359;74158;97566.51216744013;100469;100503;103112;87559.56220218858;87639;88958;90370.64444033345;90790.63814042795;50791;64484.35515644783;65234;66856;70506.57199946608;10907.945460272647;10935.83596246041;11293.265937714023;11324.433778311217;11349.659510214708;42610.934726632084;43634.90912727207;45117.27633032255;47097.529024709314;47651.808704782656;58732;61903.6904815473;63347;64192.3580764205;65146.34853651592;12761.568815018194;12823.487060517475;13029.413676384396;13045.804312935503;13099.541516046893;11944.283342999448;13457.394417251444;13986.790198147239;14376.712465750417;14450.638734031734;12953.287569183785;13699.178049317074;13846.515371961934;13969.720605588034;14271.072380295247;13063.542776002794;13197.274149921846;13584.864151358755;13601.455941762219;13957.371918263905;13098.476060957455;13238.205707657571;13378.464861405435;13428.19430834153;13453.260070695815;9538.952305238707;9694.321397502106;9709.029097090235;9735.34690477824;10215.94892025535;10784.946075269574;10979.293134351716;11050.171237157085;11265.605703800327;11413.714657133638 10:03:10 INFO - PROCESS | 1648 | __end_tp_report 10:03:10 INFO - PROCESS | 1648 | __start_cc_report 10:03:10 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2670 10:03:10 INFO - PROCESS | 1648 | __end_cc_report 10:03:10 INFO - PROCESS | 1648 | __startTimestamp1495472590237__endTimestamp 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | ------- Summary: start ------- 10:03:10 INFO - PROCESS | 1648 | Number of tests: 6 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5930.94 Median:6199.38 stddev:649.31 (10.5%) stddev-sans-first:616.69 10:03:10 INFO - PROCESS | 1648 | Values: 3264.7 3405.1 3426.4 3457.0 3463.4 5979.9 6006.3 6013.6 6036.3 6046.2 6005.9 6072.8 6076.5 6086.4 6094.3 5400.3 5440.2 5446.8 5451.5 5583.8 5319.7 5324.3 5389.6 5402.2 5496.6 5430.8 5433.2 5441.2 5441.9 5471.2 5438.4 5439.6 5441.1 5447.3 5456.9 5255.6 5383.2 5392.8 5394.4 5428.1 6062.3 6062.4 6068.2 6069.7 6077.5 6288.2 6309.6 6312.0 6326.1 6326.2 6252.4 6254.0 6296.5 6346.9 6359.0 6084.9 6135.2 6139.4 6163.5 6164.4 6201.6 6286.6 6554.3 6555.9 6557.5 6204.8 6261.6 6275.1 6290.1 6303.7 6331.5 6375.3 6387.6 6387.9 6413.0 6202.7 6323.6 6331.1 6331.4 6331.8 6217.3 6231.0 6244.8 6321.0 6358.3 5149.6 5164.1 5170.9 5183.4 5200.0 3941.3 4581.4 4598.9 4602.1 4638.9 5808.3 5868.7 5926.3 6014.8 6098.8 6249.3 6313.8 6351.1 6375.0 6380.1 5955.3 5999.4 6019.2 6037.3 6046.3 5497.0 5640.1 5641.5 5660.2 5666.3 6304.9 6414.1 6469.1 6557.6 6628.0 6359.6 6397.0 6413.1 6420.3 6420.6 6520.6 6606.1 6607.8 6631.1 6639.1 6225.9 6307.7 6323.9 6342.1 6348.6 6268.7 6281.9 6282.7 6291.2 6324.7 6279.7 6282.7 6300.8 6306.1 6318.9 6291.2 6305.6 6307.1 6310.7 6311.5 5328.2 5858.3 6064.7 6300.9 6309.9 6175.8 6199.4 6216.7 6296.8 6313.8 6149.8 6152.4 6160.0 6267.7 6267.7 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:54676.80 Median:28011.29 stddev:112221.22 (400.6%) stddev-sans-first:112463.13 10:03:10 INFO - PROCESS | 1648 | Values: 801.8 813.1 888.7 895.2 984.2 28311.9 38386.4 39513.2 39653.0 39697.4 38191.0 38337.8 38458.2 38522.0 38561.6 7465.7 7699.8 7930.4 8051.7 11498.0 11354.9 11475.8 11506.7 11511.2 11514.5 9819.8 11494.0 11536.3 11539.7 11540.7 11461.2 11476.8 11487.7 11493.4 11514.3 11193.6 11238.4 11239.4 11247.9 11251.9 38962.6 39060.8 39121.2 39134.8 39135.4 3829.3 3882.0 3885.6 3893.1 3910.9 26929.6 27570.9 28685.3 28787.0 29170.2 3073.4 3145.3 3212.1 3303.7 3304.4 346235.0 347193.0 347487.0 347545.0 347779.0 51663.2 52144.0 52272.0 52364.0 52386.0 53130.2 53195.0 53212.5 53235.7 53369.5 14585.3 14993.3 15047.8 15052.7 15080.9 12962.2 12967.7 12972.1 12978.4 12993.1 11333.9 11777.4 11806.5 11841.1 11922.0 5289.3 5354.2 5357.9 5361.3 5374.8 981.5 1098.9 1120.5 1164.7 1217.7 23258.7 24497.7 26224.2 26227.6 26298.7 1263.7 1266.7 1271.0 1314.4 1315.8 12720.4 13435.3 13468.5 13772.7 13773.7 448224.0 448558.0 449296.0 450235.7 451799.0 54320.7 54347.5 54373.5 54443.5 54464.5 1257.9 1275.0 1421.9 1480.7 1483.5 18730.9 19414.8 26707.3 27243.3 27251.7 42859.0 43234.4 43257.1 43305.4 43364.8 458985.0 460218.0 460851.0 461408.0 461525.0 22787.1 23339.0 26926.3 27922.7 28099.9 36516.6 36605.5 36620.9 36701.7 36815.3 24814.4 25140.1 25624.5 25922.9 27033.5 25994.4 26729.2 27043.6 27129.9 27207.7 25690.2 29653.4 30544.5 30749.4 30773.2 26724.0 27029.3 27066.6 27187.3 27540.9 17181.7 18553.9 21032.6 22118.8 22154.3 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:41924.29 Median:21797.17 stddev:123998.38 (568.9%) stddev-sans-first:124307.07 10:03:10 INFO - PROCESS | 1648 | Values: 418.9 429.3 429.7 436.1 440.4 20743.2 21321.8 21850.3 22204.0 22568.2 22270.8 22605.5 22942.5 23556.5 23902.4 5230.5 6598.8 6800.1 6835.3 6898.3 6742.3 6810.7 6843.0 6845.2 6878.3 6476.6 6774.2 6850.2 6858.0 6865.7 6451.6 6694.6 6725.6 6747.5 6781.5 6586.7 6591.0 6597.5 6601.4 6602.6 26731.2 26745.8 26846.8 26853.7 27131.0 2780.3 2803.1 2974.4 2980.9 2997.3 15813.2 16133.0 16507.8 17697.4 17810.0 2037.4 2062.2 2066.7 2085.4 2094.1 103762.0 107343.9 124870.8 129708.7 132269.3 20917.3 21386.9 21468.4 21732.8 21744.0 35182.0 35670.6 35951.8 35960.5 36019.8 10740.2 10991.7 11160.1 11172.2 11416.3 9081.6 9090.0 9098.5 9290.2 9304.9 8466.7 10230.6 10346.4 10378.5 10469.7 3553.7 3659.5 4259.7 4281.4 4300.7 1013.7 1026.9 1027.4 1028.6 1067.0 21928.0 22465.2 22478.0 22764.8 22771.3 891.7 1020.5 1042.1 1049.6 1057.8 11152.3 11678.0 11757.5 11762.5 11792.9 582951.0 773454.0 782979.0 783067.0 803919.0 115895.7 130674.0 132562.0 134402.0 159367.2 1257.9 1295.5 1315.7 1319.5 1319.5 18503.7 20025.9 20042.3 20091.5 20118.7 60460.0 64255.7 64620.4 64807.0 65031.7 90561.0 90887.0 92967.0 93273.5 95070.5 11100.9 11169.2 11256.7 11716.5 11761.4 12329.4 12359.8 12552.9 12616.6 12741.8 10869.1 10916.2 10923.1 10983.2 11076.4 9914.8 9996.8 10167.1 10232.3 10334.1 10865.9 11055.8 11102.2 11165.3 11342.3 9612.8 11204.4 11322.6 11377.5 11745.5 9235.5 10460.3 10719.6 10759.4 10873.9 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:6590.66 Median:3766.08 stddev:4123.16 (109.5%) stddev-sans-first:4115.95 10:03:10 INFO - PROCESS | 1648 | Values: 1353.4 1575.3 1599.9 1605.2 1613.5 9253.2 9662.0 10775.8 11068.2 11225.2 10827.7 10980.9 10982.2 10986.5 10988.0 2355.3 2402.3 2403.8 2404.5 2408.8 1709.0 2119.5 2362.9 2432.4 2453.4 2379.1 2404.7 2405.3 2410.9 2410.9 2352.2 2390.0 2395.4 2395.7 2397.3 2270.2 2331.6 2340.5 2391.5 2394.9 11114.4 11254.8 11264.6 11266.4 11323.8 5797.8 5980.8 5983.8 5984.3 6002.0 2828.4 3497.0 3549.2 3552.3 3552.6 1064.2 1143.8 1186.6 1194.2 1245.1 15306.2 15348.4 15547.6 15573.8 15594.6 4759.5 4782.9 4795.9 4880.4 4903.0 12966.2 12970.9 12972.4 12997.6 13000.1 5896.8 5993.1 6008.4 6011.1 6011.2 4509.1 5149.4 5267.7 5322.9 5340.1 3024.7 3604.7 3927.4 4040.2 4061.6 1056.5 1079.4 1080.2 1098.3 1101.3 935.6 955.2 958.7 960.3 1004.4 5542.7 5687.2 6689.6 6720.0 6871.5 1027.6 1032.7 1038.9 1043.9 1044.2 4233.6 4250.8 4294.8 4369.3 4399.5 13464.0 14061.9 14071.3 14089.9 14092.8 13513.2 13845.4 13991.1 14032.4 14171.4 9979.2 10220.9 10279.5 10380.1 10393.6 5747.9 5891.8 5985.5 6010.2 6085.6 9225.0 9286.6 9292.3 9406.3 9453.7 9390.5 9451.8 9564.2 9597.7 9609.6 9169.4 9258.4 9274.6 9406.0 9413.9 9029.6 9241.2 9336.3 9416.4 10008.5 8660.0 8797.3 8934.3 9000.2 9002.0 7575.5 8714.8 8716.0 8743.5 8823.9 7770.1 7947.8 7951.2 7955.0 7957.9 5914.4 5939.9 5941.9 6118.5 6156.7 5953.4 5956.8 6100.5 6209.2 6288.7 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4458.91 Median:4997.95 stddev:1290.19 (25.8%) stddev-sans-first:1255.99 10:03:10 INFO - PROCESS | 1648 | Values: 327.3 379.4 387.9 388.3 390.3 5067.4 5083.5 5165.0 5174.5 5185.3 4851.2 4997.9 5060.7 5073.2 5082.7 3505.8 3945.9 3988.6 4041.9 4044.7 3586.2 3951.9 3993.6 4042.2 4044.6 4022.7 4037.2 4043.8 4045.2 4052.0 3171.6 3609.6 3809.3 4027.4 4082.0 3195.9 3543.9 3566.7 3568.4 3586.2 3955.9 4058.7 5008.0 5012.8 5017.4 4186.3 4316.9 4642.5 4645.3 4657.8 5094.9 5314.5 5321.3 5321.6 5417.4 3713.1 4195.6 4297.0 4300.6 4336.8 5194.3 5472.7 5489.4 5600.8 5801.3 3079.5 3571.0 3596.8 3933.2 4252.4 4077.4 4347.7 4429.3 4563.8 4570.8 4430.7 4431.7 4810.9 4812.3 4885.5 4451.0 5069.6 5321.4 5323.8 5423.9 1342.5 1351.5 1378.6 1391.7 1485.7 1034.6 1064.5 1093.4 1140.3 1140.8 4236.9 4751.4 4998.0 5014.4 5074.3 5550.3 5562.5 5612.8 5627.8 5639.4 4537.8 4754.1 4818.8 5010.3 5021.7 2491.6 2656.6 2761.4 2877.1 2936.2 5414.9 5503.4 5826.2 5827.6 5842.6 5181.7 5543.2 5607.6 5619.9 5710.4 4713.6 5182.5 5429.8 5503.7 5605.7 4364.4 5411.6 5426.7 5545.4 5581.9 5200.9 5324.0 5531.5 5541.3 5563.7 5087.7 5111.9 5155.2 5658.0 5800.6 3956.3 4210.7 4234.8 4363.9 4465.7 4837.7 5095.8 5519.9 5646.4 5706.5 5122.8 5309.4 5344.9 5346.0 5374.4 5230.0 5346.0 5389.7 5425.5 5448.4 5106.0 5130.5 5240.8 5242.2 5335.8 4854.9 4950.8 5372.5 5392.0 5428.7 4938.1 5219.8 5252.4 5352.3 5361.4 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:19839.90 Median:23464.65 stddev:27997.26 (119.3%) stddev-sans-first:28039.01 10:03:10 INFO - PROCESS | 1648 | Values: 724.3 747.6 773.3 845.1 847.9 15179.6 15908.4 15948.3 16037.3 16046.4 14671.8 16694.5 16874.8 17186.2 17494.2 953.5 977.3 980.6 982.0 983.5 840.3 955.8 975.1 979.6 980.5 1041.2 1044.5 1045.9 1046.8 1047.3 1033.4 1038.4 1039.3 1040.9 1040.9 774.2 774.9 775.2 775.3 777.7 15923.0 16241.4 16300.1 16762.9 17002.4 14199.9 14267.4 14427.0 14490.5 14505.6 11541.2 11739.6 11762.8 11829.6 12434.9 3525.9 3708.1 3768.1 3791.6 3895.8 86484.0 104508.0 114634.9 114708.4 118851.2 10098.1 10553.6 10620.9 11015.9 11257.7 22924.7 23242.3 23460.4 23468.9 23480.6 7869.8 7872.4 7904.5 7970.8 8136.9 4330.4 4372.0 4391.2 4430.8 4569.4 3409.9 3470.9 3493.0 3493.4 3496.7 509.8 629.8 632.3 635.4 637.2 666.6 683.2 700.4 704.9 728.2 10117.6 10239.1 10304.1 10418.9 10445.9 658.5 703.6 704.8 706.4 711.5 4706.2 4971.7 5026.1 5031.5 5038.1 74158.0 97566.5 100469.0 100503.0 103112.0 87559.6 87639.0 88958.0 90370.6 90790.6 50791.0 64484.4 65234.0 66856.0 70506.6 10907.9 10935.8 11293.3 11324.4 11349.7 42610.9 43634.9 45117.3 47097.5 47651.8 58732.0 61903.7 63347.0 64192.4 65146.3 12761.6 12823.5 13029.4 13045.8 13099.5 11944.3 13457.4 13986.8 14376.7 14450.6 12953.3 13699.2 13846.5 13969.7 14271.1 13063.5 13197.3 13584.9 13601.5 13957.4 13098.5 13238.2 13378.5 13428.2 13453.3 9539.0 9694.3 9709.0 9735.3 10215.9 10784.9 10979.3 11050.2 11265.6 11413.7 10:03:10 INFO - PROCESS | 1648 | -------- Summary: end -------- 10:03:10 INFO - PROCESS | 1648 | 10:03:10 INFO - TEST-INFO | 1648: exit 0 10:03:10 INFO - TEST-OK | dromaeo_css | took 1119940ms 10:03:10 INFO - TEST-START | kraken 10:03:10 INFO - operating with platform_type : mac_ 10:03:10 INFO - Initialising browser for kraken test... 10:03:10 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpCKOdlJ/profile http://localhost:49248/getInfo.html) 10:03:12 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 10:03:12 INFO - PROCESS | 1654 | colorDepth:24 10:03:12 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 10:03:12 INFO - PROCESS | 1654 | __metrics 10:03:12 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:03:12 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:03:13 INFO - TEST-INFO | 1654: exit 0 10:03:13 INFO - Browser initialized. 10:03:13 INFO - Running cycle 1/1 for kraken test... 10:03:13 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpCKOdlJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:25 INFO - PROCESS | 1655 | RSS: Main: 193556480 10:03:25 INFO - PROCESS | 1655 | 10:03:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:03:29 INFO - PROCESS | 1655 | RSS: Main: 244793344 10:03:29 INFO - PROCESS | 1655 | 10:03:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:03:32 INFO - PROCESS | 1655 | RSS: Main: 260239360 10:03:32 INFO - PROCESS | 1655 | 10:03:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:03:36 INFO - PROCESS | 1655 | RSS: Main: 357175296 10:03:36 INFO - PROCESS | 1655 | 10:03:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:03:38 INFO - PROCESS | 1655 | RSS: Main: 260292608 10:03:38 INFO - PROCESS | 1655 | 10:03:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:41 INFO - PROCESS | 1655 | RSS: Main: 261619712 10:03:41 INFO - PROCESS | 1655 | 10:03:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:45 INFO - PROCESS | 1655 | RSS: Main: 301563904 10:03:45 INFO - PROCESS | 1655 | 10:03:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:48 INFO - PROCESS | 1655 | RSS: Main: 303312896 10:03:48 INFO - PROCESS | 1655 | 10:03:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:03:52 INFO - PROCESS | 1655 | RSS: Main: 299696128 10:03:52 INFO - PROCESS | 1655 | 10:03:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:03:54 INFO - PROCESS | 1655 | RSS: Main: 276598784 10:03:54 INFO - PROCESS | 1655 | 10:03:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:03:57 INFO - PROCESS | 1655 | RSS: Main: 280788992 10:03:57 INFO - PROCESS | 1655 | 10:03:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:00 INFO - PROCESS | 1655 | RSS: Main: 284401664 10:04:00 INFO - PROCESS | 1655 | 10:04:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:03 INFO - PROCESS | 1655 | RSS: Main: 299565056 10:04:03 INFO - PROCESS | 1655 | 10:04:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:07 INFO - PROCESS | 1655 | RSS: Main: 293359616 10:04:07 INFO - PROCESS | 1655 | 10:04:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:04:09 INFO - PROCESS | 1655 | RSS: Main: 338018304 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | __start_tp_report 10:04:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 10:04:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 10:04:09 INFO - PROCESS | 1655 | |i|pagename|runs| 10:04:09 INFO - PROCESS | 1655 | |0;ai-astar;105;116;115;115;115;115;115;116;114;115 10:04:09 INFO - PROCESS | 1655 | |1;audio-beat-detection;140;109;105;138;128;132;133;106;127;107 10:04:09 INFO - PROCESS | 1655 | |2;audio-dft;184;185;182;186;184;185;236;248;185;184 10:04:09 INFO - PROCESS | 1655 | |3;audio-fft;83;61;59;92;62;62;61;61;89;80 10:04:09 INFO - PROCESS | 1655 | |4;audio-oscillator;91;69;86;70;71;68;82;68;68;83 10:04:09 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;88;89;89;88;91;132;108;87;88 10:04:09 INFO - PROCESS | 1655 | |6;imaging-darkroom;133;96;94;98;94;95;94;97;95;102 10:04:09 INFO - PROCESS | 1655 | |7;imaging-desaturate;85;83;86;83;84;82;85;84;83;101 10:04:09 INFO - PROCESS | 1655 | |8;json-parse-financial;62;60;63;62;64;63;64;64;65;65 10:04:09 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;61;59;63;62;59;58;57;57;58;59 10:04:09 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;85;82;84;86;82;82;82;100;93;98 10:04:09 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;139;138;140;124;136;137;141;140;177;136 10:04:09 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;164;161;165;165;161;164;161;156;162;168 10:04:09 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;65;64;73;81;78;78;78;63;63 10:04:09 INFO - PROCESS | 1655 | __end_tp_report 10:04:09 INFO - PROCESS | 1655 | __start_cc_report 10:04:09 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2204 10:04:09 INFO - PROCESS | 1655 | __end_cc_report 10:04:09 INFO - PROCESS | 1655 | __startTimestamp1495472649118__endTimestamp 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | ------- Summary: start ------- 10:04:09 INFO - PROCESS | 1655 | Number of tests: 14 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:3.25 (2.8%) stddev-sans-first:0.60 10:04:09 INFO - PROCESS | 1655 | Values: 105.0 116.0 115.0 115.0 115.0 115.0 115.0 116.0 114.0 115.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:130.00 stddev:14.14 (10.9%) stddev-sans-first:13.50 10:04:09 INFO - PROCESS | 1655 | Values: 140.0 109.0 105.0 138.0 128.0 132.0 133.0 106.0 127.0 107.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:195.90 Median:185.00 stddev:24.48 (13.2%) stddev-sans-first:25.59 10:04:09 INFO - PROCESS | 1655 | Values: 184.0 185.0 182.0 186.0 184.0 185.0 236.0 248.0 185.0 184.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:71.00 Median:71.00 stddev:13.32 (18.8%) stddev-sans-first:13.40 10:04:09 INFO - PROCESS | 1655 | Values: 83.0 61.0 59.0 92.0 62.0 62.0 61.0 61.0 89.0 80.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.88 (11.6%) stddev-sans-first:7.47 10:04:09 INFO - PROCESS | 1655 | Values: 91.0 69.0 86.0 70.0 71.0 68.0 82.0 68.0 68.0 83.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:88.00 stddev:14.47 (16.4%) stddev-sans-first:15.14 10:04:09 INFO - PROCESS | 1655 | Values: 88.0 88.0 89.0 89.0 88.0 91.0 132.0 108.0 87.0 88.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:95.00 stddev:11.92 (12.6%) stddev-sans-first:2.62 10:04:09 INFO - PROCESS | 1655 | Values: 133.0 96.0 94.0 98.0 94.0 95.0 94.0 97.0 95.0 102.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:84.00 stddev:5.54 (6.6%) stddev-sans-first:5.87 10:04:09 INFO - PROCESS | 1655 | Values: 85.0 83.0 86.0 83.0 84.0 82.0 85.0 84.0 83.0 101.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:64.00 stddev:1.55 (2.4%) stddev-sans-first:1.58 10:04:09 INFO - PROCESS | 1655 | Values: 62.0 60.0 63.0 62.0 64.0 63.0 64.0 64.0 65.0 65.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:2.06 (3.5%) stddev-sans-first:2.09 10:04:09 INFO - PROCESS | 1655 | Values: 61.0 59.0 63.0 62.0 59.0 58.0 57.0 57.0 58.0 59.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:84.50 stddev:6.98 (8.3%) stddev-sans-first:7.35 10:04:09 INFO - PROCESS | 1655 | Values: 85.0 82.0 84.0 86.0 82.0 82.0 82.0 100.0 93.0 98.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.50 stddev:13.60 (9.8%) stddev-sans-first:14.41 10:04:09 INFO - PROCESS | 1655 | Values: 139.0 138.0 140.0 124.0 136.0 137.0 141.0 140.0 177.0 136.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:164.00 stddev:3.27 (2.0%) stddev-sans-first:3.43 10:04:09 INFO - PROCESS | 1655 | Values: 164.0 161.0 165.0 165.0 161.0 164.0 161.0 156.0 162.0 168.0 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:75.50 stddev:7.37 (9.8%) stddev-sans-first:7.60 10:04:09 INFO - PROCESS | 1655 | Values: 66.0 65.0 64.0 73.0 81.0 78.0 78.0 78.0 63.0 63.0 10:04:09 INFO - PROCESS | 1655 | -------- Summary: end -------- 10:04:09 INFO - PROCESS | 1655 | 10:04:09 INFO - TEST-INFO | 1655: exit 0 10:04:09 INFO - TEST-OK | kraken | took 59205ms 10:04:09 INFO - SUITE-END | took 1179s 10:04:10 INFO - Completed test suite (00:19:39) 10:04:10 INFO - javascript benchmark 10:04:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7631.576083769964, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.6735326467356, 3405.063607507935, 3426.434638284683, 3456.9827150864244, 3463.35927853347, 5979.850503737409, 6006.309274433442, 6013.609115407507, 6036.305824830135, 6046.183765191698, 6005.909911351322, 6072.8178154655325, 6076.483498902588, 6086.391360863922, 6094.329623741385, 5400.29796126504, 5440.238366628655, 5446.809361672343, 5451.536619387357, 5583.804566840141, 5319.6808191508635, 5324.307839980797, 5389.595780316472, 5402.189671549259, 5496.642718223303, 5430.755615997289, 5433.239346491494, 5441.183822426648, 5441.891162176754, 5471.151971444432, 5438.374586922476, 5439.5920305977015, 5441.129419292934, 5447.291852059247, 5456.890862182754, 5255.60582956276, 5383.16560933056, 5392.757325920304, 5394.352677678665, 5428.131498960148, 6062.272527296708, 6062.42406971337, 6068.180795592582, 6069.696515174268, 6077.453029227391, 6288.151099601587, 6309.621422714652, 6312.0, 6326.051092336141, 6326.240851097852, 6252.406021427957, 6254.0, 6296.527760417987, 6346.904796428057, 6359.0, 6084.878302433971, 6135.171751813537, 6139.416755408229, 6163.537734669918, 6164.445199932027, 6201.596896201732, 6286.591371560834, 6554.344565543408, 6555.93444065558, 6557.475401967831, 6204.81385558434, 6261.624302541771, 6275.058741188858, 6290.119383286344, 6303.6532990685955, 6331.461825744863, 6375.330590288046, 6387.616742995435, 6387.904181437282, 6413.0, 6202.72087756052, 6323.5573509854785, 6331.113644089831, 6331.366863313632, 6331.778387756406, 6217.285012223652, 6231.034189700513, 6244.843878903063, 6320.968395158086, 6358.300586935434, 5149.613778966593, 5164.096283150434, 5170.939957308743, 5183.377994640592, 5200.011997720497, 3941.2708648900043, 4581.40441742578, 4598.931016034762, 4602.125596136723, 4638.860834174912, 5808.273965754281, 5868.706564671835, 5926.348101708809, 6014.849628759229, 6098.817035488943, 6249.25008998923, 6313.842153946188, 6351.110844481776, 6374.968125159345, 6380.138681277968, 5955.285365756137, 5999.430054144849, 6019.157317975487, 6037.335893051761, 6046.274447066292, 5497.038018346853, 5640.097584386478, 5641.548676105902, 5660.15097735343, 5666.320041594952, 6304.873902522016, 6414.102025716404, 6469.061986011908, 6557.573757705733, 6628.0, 6359.586626869239, 6397.0, 6413.0701048348665, 6420.3258657842125, 6420.550561460653, 6520.576162549419, 6606.108175396452, 6607.80176594703, 6631.104800851823, 6639.103720997604, 6225.906611400923, 6307.653079080695, 6323.905141422791, 6342.143810585512, 6348.619082855043, 6268.655223962726, 6281.905771413341, 6282.685865706605, 6291.245050593958, 6324.715387807468, 6279.748810047547, 6282.685865706788, 6300.842478938063, 6306.117143599808, 6318.873622527615, 6291.213598300213, 6305.6216627000695, 6307.085472606354, 6310.652914089769, 6311.526635502448, 5328.17413300939, 5858.297004359504, 6064.696765161636, 6300.936990630035, 6309.936900630935, 6175.84560385994, 6199.380061993765, 6216.720247588779, 6296.779612713533, 6313.779017734358, 6149.831532008904, 6152.446279834837, 6159.983602705683, 6267.655278959701, 6267.686615669107], "value": 5888.545291294806, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.8356236971422, 813.0649752784298, 888.6889588643976, 895.1540793949716, 984.1831280037561, 28311.858440707794, 38386.42420363693, 39513.20973580526, 39653.008674783145, 39697.404538931936, 38191.04522386935, 38337.84986450404, 38458.23083538328, 38522.03694907622, 38561.614383856155, 7465.738699145531, 7699.769006929801, 7930.444868859182, 8051.677932882678, 11498.022668073181, 11354.886451135466, 11475.827862582068, 11506.712332191679, 11511.194216404854, 11514.539418423254, 9819.772528433945, 11494.023008044327, 11536.307821530734, 11539.65381038566, 11540.65378038656, 11461.197716159872, 11476.770464590662, 11487.712807179803, 11493.367864767435, 11514.309141451498, 11193.608223712132, 11238.381888996102, 11239.381833999127, 11247.887521124847, 11251.887481125166, 38962.61037389618, 39060.80469597662, 39121.21757564861, 39134.804325978184, 39135.41296880549, 3829.2915810574855, 3882.010087427716, 3885.5725870154542, 3893.1045859452483, 3910.9413358799643, 26929.596056059174, 27570.862145689345, 28685.28286792826, 28787.0, 29170.15591976728, 3073.3699591583672, 3145.276586385144, 3212.1166679163416, 3303.702666760003, 3304.4052070627276, 346235.0, 347193.0, 347487.0, 347545.0, 347779.0, 51663.22505162426, 52144.0, 52272.0, 52364.0, 52386.0, 53130.21828035495, 53195.0, 53212.46787532153, 53235.73382133142, 53369.46630533723, 14585.270736463346, 14993.32530036151, 15047.796176305868, 15052.698946021237, 15080.944333896521, 12962.22226666403, 12967.675808104872, 12972.09195356335, 12978.415971281314, 12993.090483666241, 11333.923277288644, 11777.352245626573, 11806.527738890349, 11841.111916606289, 11921.986631136451, 5289.312389389354, 5354.170103633943, 5357.892842143136, 5361.329833770778, 5374.838754837361, 981.4896253947907, 1098.9065879449838, 1120.464963000678, 1164.6855349055706, 1217.713837248246, 23258.65112023321, 24497.690445055563, 26224.21327360182, 26227.606585901227, 26298.737012630012, 1263.6731431996368, 1266.65167079054, 1270.993645031769, 1314.3559655768604, 1315.8092076648832, 12720.427580758704, 13435.261060641564, 13468.461261549428, 13772.65568360799, 13773.724525509433, 448224.0, 448558.0, 449296.0, 450235.7488212538, 451799.0, 54320.72839635856, 54347.45652543503, 54373.45626543763, 54443.45556544463, 54464.45535544673, 1257.9119461637597, 1275.0118658040094, 1421.8791402730676, 1480.7408703477063, 1483.5252719129776, 18730.906345468185, 19414.805851941866, 26707.33231669224, 27243.318917027234, 27251.72748272492, 42859.0, 43234.35148472838, 43257.13485730205, 43305.35041974436, 43364.78317608392, 458985.0, 460218.0, 460851.0, 461408.0, 461525.0, 22787.088516459156, 23339.0, 26926.326841828326, 27922.720772792825, 28099.859500702365, 36516.63483365239, 36605.450918235714, 36620.901372958855, 36701.71543995947, 36815.26369472542, 24814.37964050913, 25140.12009579656, 25624.487510249317, 25922.87038564795, 27033.45933081288, 25994.35014124662, 26729.19812405631, 27043.594346084432, 27129.86435067812, 27207.72792272131, 25690.229293121236, 29653.406931861675, 30544.541831872095, 30749.385012300078, 30773.23066923345, 26724.0, 27029.324266892698, 27066.594001090394, 27187.32031699144, 27540.862295688392, 17181.74227386615, 18553.907230463763, 21032.57934841264, 22118.778812211673, 22154.335369938926], "value": 18212.37851861744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.94134821125067, 429.2680978930922, 429.66116900814217, 436.0929267124381, 440.376866733572, 20743.170273189073, 21321.786782132174, 21850.344489665316, 22204.0, 22568.210112646062, 22270.77510736909, 22605.54788904221, 22942.541149177006, 23556.5288694226, 23902.40243993901, 5230.450802665722, 6598.802035938929, 6800.081988931505, 6835.3164683531495, 6898.310168983112, 6742.258351581322, 6810.659467026654, 6843.0, 6845.212800527928, 6878.312168783106, 6476.611403315793, 6774.220964589062, 6850.1779786425695, 6857.965710171442, 6865.691043903036, 6451.612903225775, 6694.56485328457, 6725.630090345029, 6747.460203183734, 6781.457483401341, 6586.736530538773, 6591.044298576728, 6597.505187110986, 6601.3728695773825, 6602.636854972975, 26731.19806405811, 26745.796439160284, 26846.791894364604, 26853.73146268532, 27131.0, 2780.263230243987, 2803.1450407625666, 2974.434857377113, 2980.925476863096, 2997.310618557722, 15813.209339532978, 16133.0, 16507.752383714254, 17697.38059167923, 17810.0, 2037.4295197344768, 2062.2163577840474, 2066.71066050753, 2085.353540402465, 2094.099537199019, 103762.0, 107343.92656073495, 124870.75129248682, 129708.7029129706, 132269.33865330613, 20917.26789562358, 21386.893065534572, 21468.355949321547, 21732.78267217339, 21744.0, 35182.0, 35670.64329356673, 35951.820240898625, 35960.46059309113, 36019.838809671506, 10740.248182627141, 10991.670249892515, 11160.0513956313, 11172.162087843444, 11416.257943233662, 9081.636734530677, 9090.045545217788, 9098.453262945315, 9290.210332121711, 9304.8604270936, 8466.661333546712, 10230.567720519133, 10346.430946297874, 10378.532966016548, 10469.738256543495, 3553.680168784822, 3659.5059666945153, 4259.701820872509, 4281.431141315186, 4300.65594752419, 1013.6857574152036, 1026.9127124194526, 1027.3989716016215, 1028.5628607841638, 1066.989330106689, 21928.0, 22465.213717520135, 22478.0, 22764.772352276595, 22771.31686049421, 891.6745387933487, 1020.454057079459, 1042.135027926819, 1049.6483677967813, 1057.7831544533353, 11152.275102118336, 11678.0, 11757.529698812123, 11762.470688819023, 11792.941035294769, 582951.0, 773454.0, 782979.0, 783067.0, 803919.0, 115895.6820863578, 130674.0, 132562.0, 134402.0, 159367.20316398575, 1257.861635220125, 1295.4688577683105, 1315.7302752935625, 1319.4788058716754, 1319.4788058716945, 18503.722444163617, 20025.899870500554, 20042.298519551747, 20091.497712557302, 20118.69821952701, 60460.0, 64255.67872160609, 64620.353796463314, 64807.0, 65031.67484162549, 90561.0, 90887.0, 92967.0, 93273.53811695184, 95070.52464737909, 11100.888991109985, 11169.162312826407, 11256.662300131009, 11716.472758726048, 11761.353125578175, 12329.383530823603, 12359.75280494403, 12552.937235313764, 12616.621501354974, 12741.80887286673, 10869.076128529163, 10916.216364826918, 10923.071538919281, 10983.231173817756, 11076.446177691245, 9914.801703965735, 9996.800063998533, 10167.084962353423, 10232.334898231591, 10334.069933706003, 10865.891341086804, 11055.778884422427, 11102.167337449562, 11165.274257173258, 11342.262752921364, 9612.807743845224, 11204.383758893338, 11322.60370887015, 11377.4880130396, 11745.47145378443, 9235.49204793716, 10460.320079194827, 10719.624813131502, 10759.3544387337, 10873.945630272114], "value": 11650.004350748462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.3503918119309, 1575.2517554161775, 1599.880008999325, 1605.237512181713, 1613.5240104169268, 9253.213476854467, 9662.0, 10775.83836242456, 11068.169887258447, 11225.214235003554, 10827.6751697449, 10980.890191098086, 10982.231243812936, 10986.450677466115, 10988.0, 2355.2698663414353, 2402.315340128064, 2403.807695384374, 2404.4710163763943, 2408.8313818032743, 1709.025855262501, 2119.5231073008604, 2362.8582285062953, 2432.3797431654903, 2453.3621258472836, 2379.095943541452, 2404.675368825204, 2405.3265085775924, 2410.8794560272004, 2410.915617953372, 2352.1532248390567, 2390.008146619151, 2395.4131237846664, 2395.748446413136, 2397.29279862441, 2270.194081101202, 2331.63859601762, 2340.508493216427, 2391.4619210677633, 2394.856308621488, 11114.444277786079, 11254.774904501946, 11264.605738799184, 11266.380349080797, 11323.830142547786, 5797.768089276424, 5980.790672326491, 5983.760649574012, 5984.3417224105315, 6002.0, 2828.3636181859124, 3496.968394323655, 3549.1836877518317, 3552.342816578941, 3552.5559305086863, 1064.1699474409972, 1143.805553055974, 1186.590626233948, 1194.247623996885, 1245.103525461666, 15306.234688265542, 15348.386064557404, 15547.611309717235, 15573.844261557353, 15594.610134746608, 4759.4551012534175, 4782.856514304576, 4795.856124316276, 4880.389951256093, 4903.01939612079, 12966.157199782172, 12970.897473714651, 12972.416241269166, 12997.610071697864, 13000.08999370035, 5896.7641294348605, 5993.0710739835395, 6008.429199226067, 6011.068284415923, 6011.158437818709, 4509.098180363941, 5149.382074151051, 5267.657602255841, 5322.866928326823, 5340.145576707708, 3024.742896853792, 3604.729645276562, 3927.430522574211, 4040.1919616076902, 4061.614146656063, 1056.4717641179411, 1079.433297518809, 1080.152080616712, 1098.319042193845, 1101.2841652925501, 935.6397786852111, 955.1594596754811, 958.6836344006462, 960.2558017536466, 1004.4481276427937, 5542.722863856791, 5687.175359572839, 6689.565178263398, 6719.966400167968, 6871.4502839772695, 1027.6300531808542, 1032.6798692405378, 1038.8649475568127, 1043.9269251152346, 1044.1698849414581, 4233.640140588023, 4250.766207858535, 4294.806733696991, 4369.257226271541, 4399.450068741407, 13464.0, 14061.929690351482, 14071.2964351782, 14089.85910140906, 14092.788608170886, 13513.189208647513, 13845.376958036912, 13991.090579112326, 14032.438702451991, 14171.433142674383, 9979.151772099307, 10220.897791022144, 10279.53742081623, 10380.117689996436, 10393.584256629802, 5747.942520574741, 5891.823245302648, 5985.521158307412, 6010.1585777991995, 6085.588545711633, 9225.0, 9286.62853485853, 9292.349535532448, 9406.294527910297, 9453.716388508356, 9390.483523406278, 9451.810963780823, 9564.234861211226, 9597.712068637951, 9609.615615375586, 9169.40398874071, 9258.35191536586, 9274.582643780912, 9406.0, 9413.905860941302, 9029.593668285075, 9241.168294853227, 9336.29977751685, 9416.387934784218, 10008.549615267184, 8660.0, 8797.340199484936, 8934.329925255503, 9000.23498002651, 9002.0, 7575.46971711997, 8714.825703486022, 8715.95408550978, 8743.475391476532, 8823.867641985247, 7770.14528401864, 7947.801304967422, 7951.204879512003, 7955.0, 7957.880631790412, 5914.408559144051, 5939.940600593939, 5941.881162376641, 6118.510519158368, 6156.692165391623, 5953.404659534012, 5956.792420070835, 6100.481459076028, 6209.161763161916, 6288.748450061947], "value": 5057.823687067422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.31754292300553, 379.37782037458555, 387.9010852232682, 388.28167889404585, 390.2779857264061, 5067.366579177603, 5083.491650834914, 5165.0, 5174.508421699942, 5185.32955527903, 4851.1753001989655, 4997.925031124536, 5060.746962651871, 5073.239014147871, 5082.695038297705, 3505.754597178192, 3945.9013524661827, 3988.6210809973004, 4041.939370909439, 4044.6562042226446, 3586.1751797086686, 3951.940720889189, 3993.620606042436, 4042.1915616876595, 4044.5550989391145, 4022.658074063708, 4037.1925614876995, 4043.818028188724, 4045.231406032859, 4051.9942628398985, 3171.57183780189, 3609.628341230342, 3809.29528037314, 4027.3757567576927, 4081.9795051237043, 3195.8561864716144, 3543.9114022149392, 3566.7146628269675, 3568.37553428149, 3586.22896077342, 3955.881323560298, 4058.736182148151, 5007.973365460072, 5012.774425150877, 5017.448080711119, 4186.267403204427, 4316.892077698051, 4642.51253618372, 4645.256758918556, 4657.767111644438, 5094.949050509485, 5314.468553144693, 5321.281626980347, 5321.620770810525, 5417.377001644822, 3713.1088538750773, 4195.643370313527, 4296.957030429687, 4300.61294483498, 4336.82652693895, 5194.324737784102, 5472.72636368184, 5489.4236105209175, 5600.803971861006, 5801.3328467225965, 3079.4610943085318, 3571.0181998031417, 3596.8021758803516, 3933.193695292458, 4252.4046633471335, 4077.368007958771, 4347.7173983690955, 4429.2913133899065, 4563.794629241625, 4570.771461426915, 4430.712003719812, 4431.7340959542535, 4810.921010553248, 4812.25410061441, 4885.487023862514, 4451.0, 5069.594432445396, 5321.388040375329, 5323.817234933658, 5423.864403389868, 1342.5232244530937, 1351.4999450203488, 1378.5864240727742, 1391.7007843313534, 1485.6657252118187, 1034.5965073621294, 1064.5209655654987, 1093.4478088565224, 1140.2816225777708, 1140.8021577343923, 4236.851710190129, 4751.382320298339, 4997.9750101249265, 5014.448410674823, 5074.289599456005, 5550.306211723535, 5562.499375056183, 5612.828751755245, 5627.774889004476, 5639.351474580476, 4537.818487260539, 4754.144254034307, 4818.831340903052, 5010.2735103409805, 5021.748912554358, 2491.638712386694, 2656.5749480083095, 2761.351082495612, 2877.0937154796593, 2936.2219011961847, 5414.8917021659345, 5503.394626591072, 5826.184334193216, 5827.562932780059, 5842.649441033552, 5181.663191892515, 5543.223948647193, 5607.551395888319, 5619.8595035124445, 5710.371859095496, 4713.599344055794, 5182.507661772125, 5429.778299882495, 5503.669779813224, 5605.719714014202, 4364.388985541963, 5411.594130440154, 5426.728663566727, 5545.417731138334, 5581.860453488695, 5200.921986170286, 5324.0, 5531.502164805026, 5541.251930989426, 5563.749631266522, 5087.734195108045, 5111.897762044664, 5155.226715992631, 5658.03813351723, 5800.59395842287, 3956.2878681836396, 4210.705250632426, 4234.830606775695, 4363.890902727458, 4465.682623626103, 4837.661363704507, 5095.77069031887, 5519.944800551943, 5646.407127251579, 5706.4864162225595, 5122.846314610568, 5309.442508536703, 5344.85085706575, 5345.973270133624, 5374.355077390738, 5229.973850130725, 5345.973270133624, 5389.676619402849, 5425.457454254543, 5448.373437054631, 5105.974470127626, 5130.510803047334, 5240.842774716764, 5242.16125419931, 5335.839924802262, 4854.907645779671, 4950.752462376795, 5372.516473517402, 5392.0, 5428.67427954324, 4938.074151081153, 5219.8434046978655, 5252.369715634149, 5352.330958630171, 5361.35663720356], "value": 4080.8299138086836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.3480867219505, 747.6411322565172, 773.3387953299929, 845.1041895590674, 847.8685803700427, 15179.620509487268, 15908.443204487845, 15948.28232729527, 16037.278322475488, 16046.438374656875, 14671.77992330116, 16694.499165025038, 16874.83125168748, 17186.226619802106, 17494.21276042578, 953.5232383808078, 977.3061126600122, 980.5734505490099, 982.0474140084107, 983.4885859353168, 840.2983508770154, 955.7801705607715, 975.1418751498671, 979.647326962293, 980.5293459139617, 1041.1878734586996, 1044.4621020174616, 1045.9424731639756, 1046.8377401502742, 1047.2983101322131, 1033.3593172233188, 1038.3614077342418, 1039.2569312941207, 1040.8646875906122, 1040.8907064758205, 774.2025713515088, 774.9263819937097, 775.2015424113173, 775.3061010395664, 777.7044723005279, 15923.044617322998, 16241.350345986146, 16300.103494307808, 16762.916185419115, 17002.40491582801, 14199.858001419956, 14267.429302827875, 14427.0, 14490.492832750802, 14505.564833055025, 11541.192116551845, 11739.647810565697, 11762.823557646641, 11829.585964491287, 12434.875651243552, 3525.9118522036897, 3708.1100535871196, 3768.0956570423177, 3791.6018818023986, 3895.8052097395303, 86484.0, 104508.0, 114634.85365146326, 114708.42645786802, 118851.21723174246, 10098.091171794427, 10553.63062292816, 10620.893791062144, 11015.889841101647, 11257.662270131908, 22924.656130158062, 23242.302730918098, 23460.413489662555, 23468.882655586614, 23480.64779028316, 7869.803254918558, 7872.44892857506, 7904.525728456311, 7970.84058318842, 8136.877946830802, 4330.437043184366, 4371.956280437218, 4391.231534481453, 4430.82276708928, 4569.360289559464, 3409.8636054558037, 3470.878519251814, 3492.9825350873593, 3493.3886569850174, 3496.7027802636553, 509.76507086013333, 629.7827249598881, 632.3044650883991, 635.3773302163813, 637.178040327981, 666.6366830077619, 683.2211279141783, 700.425650966213, 704.9365557099783, 728.2104992737711, 10117.645882394081, 10239.078482936571, 10304.072633463024, 10418.895811041944, 10445.9477702611, 658.4777776127465, 703.6165289917008, 704.7709494414336, 706.3713295167305, 711.4699548836151, 4706.247000479907, 4971.701697898137, 5026.145555255615, 5031.471695471922, 5038.118329292359, 74158.0, 97566.51216744013, 100469.0, 100503.0, 103112.0, 87559.56220218858, 87639.0, 88958.0, 90370.64444033345, 90790.63814042795, 50791.0, 64484.35515644783, 65234.0, 66856.0, 70506.57199946608, 10907.945460272647, 10935.83596246041, 11293.265937714023, 11324.433778311217, 11349.659510214708, 42610.934726632084, 43634.90912727207, 45117.27633032255, 47097.529024709314, 47651.808704782656, 58732.0, 61903.6904815473, 63347.0, 64192.3580764205, 65146.34853651592, 12761.568815018194, 12823.487060517475, 13029.413676384396, 13045.804312935503, 13099.541516046893, 11944.283342999448, 13457.394417251444, 13986.790198147239, 14376.712465750417, 14450.638734031734, 12953.287569183785, 13699.178049317074, 13846.515371961934, 13969.720605588034, 14271.072380295247, 13063.542776002794, 13197.274149921846, 13584.864151358755, 13601.455941762219, 13957.371918263905, 13098.476060957455, 13238.205707657571, 13378.464861405435, 13428.19430834153, 13453.260070695815, 9538.952305238707, 9694.321397502106, 9709.029097090235, 9735.34690477824, 10215.94892025535, 10784.946075269574, 10979.293134351716, 11050.171237157085, 11265.605703800327, 11413.714657133638], "value": 7660.02292231552, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1443.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 116.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 105.0, 138.0, 128.0, 132.0, 133.0, 106.0, 127.0, 107.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 186.0, 184.0, 185.0, 236.0, 248.0, 185.0, 184.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 59.0, 92.0, 62.0, 62.0, 61.0, 61.0, 89.0, 80.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 86.0, 70.0, 71.0, 68.0, 82.0, 68.0, 68.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 89.0, 88.0, 91.0, 132.0, 108.0, 87.0, 88.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 96.0, 94.0, 98.0, 94.0, 95.0, 94.0, 97.0, 95.0, 102.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 83.0, 84.0, 82.0, 85.0, 84.0, 83.0, 101.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 63.0, 62.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 63.0, 62.0, 59.0, 58.0, 57.0, 57.0, 58.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 86.0, 82.0, 82.0, 82.0, 100.0, 93.0, 98.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 140.0, 124.0, 136.0, 137.0, 141.0, 140.0, 177.0, 136.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 165.0, 165.0, 161.0, 164.0, 161.0, 156.0, 162.0, 168.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 73.0, 81.0, 78.0, 78.0, 78.0, 63.0, 63.0], "value": 70.9, "unit": "score"}]}]} 10:04:10 INFO - Return code: 0 10:04:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:04:10 INFO - # TBPL SUCCESS # 10:04:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:04:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:04:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:04:10 INFO - 2017-05-22 10:04:10.455 screenresolution[1659:11745] starting screenresolution argv=screenresolution get 10:04:10 INFO - 2017-05-22 10:04:10.457 screenresolution[1659:11745] Display 0: 1600x1200x32@60 10:04:10 INFO - 2017-05-22 10:04:10.463 screenresolution[1660:11748] starting screenresolution argv=screenresolution list 10:04:10 INFO - Available Modes on Display 0 10:04:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:04:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:04:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:04:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:04:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:04:10 INFO - Intel Iris: 10:04:10 INFO - Chipset Model: Intel Iris 10:04:10 INFO - Type: GPU 10:04:10 INFO - Bus: Built-In 10:04:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:04:10 INFO - Vendor: Intel (0x8086) 10:04:10 INFO - Device ID: 0x0a2e 10:04:10 INFO - Revision ID: 0x0009 10:04:10 INFO - Displays: 10:04:10 INFO - Display: 10:04:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:04:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:04:10 INFO - Display Serial Number: 1600x1200 60 10:04:10 INFO - Main Display: Yes 10:04:10 INFO - Mirror: Off 10:04:10 INFO - Online: Yes 10:04:10 INFO - Rotation: Supported 10:04:10 INFO - Return code: 0 10:04:10 INFO - Running post-action listener: _resource_record_post_action 10:04:10 INFO - [mozharness: 2017-05-22 17:04:10.698538Z] Finished run-tests step (success) 10:04:10 INFO - Running post-run listener: _resource_record_post_run 10:04:10 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32807936; Write bytes: 511405056; Read time: 201; Write time: 1566 10:04:10 INFO - TinderboxPrint: CPU usage
53.9% 10:04:10 INFO - TinderboxPrint: I/O read bytes / time
32,807,936 / 201 10:04:10 INFO - TinderboxPrint: I/O write bytes / time
511,405,056 / 1,566 10:04:10 INFO - TinderboxPrint: CPU idle
2,214.8 (46.1%) 10:04:10 INFO - TinderboxPrint: CPU system
957.1 (19.9%) 10:04:10 INFO - TinderboxPrint: CPU user
1,629.7 (33.9%) 10:04:10 INFO - TinderboxPrint: Swap in / out
252,399,616 / 0 10:04:10 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203921920; Write bytes: 201586688; Read time: 15656; Write time: 444 10:04:10 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31001600; Write bytes: 299029504; Read time: 186; Write time: 1087 10:04:11 INFO - Running post-run listener: _upload_blobber_files 10:04:11 INFO - Blob upload gear active. 10:04:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:04:11 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 10:04:11 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', 'Jamun', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:04:11 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 Jamun -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:04:11 INFO - (blobuploader) - INFO - Open directory for files ... 10:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:04:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:12 INFO - (blobuploader) - INFO - Done attempting. 10:04:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:04:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:04:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:13 INFO - (blobuploader) - INFO - Done attempting. 10:04:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:04:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:14 INFO - (blobuploader) - INFO - Done attempting. 10:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:16 INFO - (blobuploader) - INFO - Done attempting. 10:04:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:04:16 INFO - Return code: 0 10:04:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:04:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:04:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1d6a61ab6378c5ffcc21d2099a34b1d6342a3388a27ef682b38be66e4539723fcf5b121da0c366c940ab139657070b9d1ad92af697b6b8f38955eb8cd7f2d93d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/993ead73b55e97b8827a864d99bee3db23899bc78d8912d2eb6ed7be9157be4e4692b7bbf476988aa74a4363b9848dc8d099ac04e14535c818f2a6722eb07d18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/23954b06521224c629cb77279e7b15afe5258ec617bed37189c80788b7c2b5edc3fe5839e6302c237eaae367ef45e90ad13819a9cd76f6ae3a88c2953117bf36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a3bc5037f554f48fe77c55d7fa83dcfc7b971333ca0a8cc61e1603f44c1c6436a54bb38f9742b0134358208738abf10c66c60ee6a3baf09db38e29456f96e0bb"} 10:04:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:04:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:04:16 INFO - Contents: 10:04:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1d6a61ab6378c5ffcc21d2099a34b1d6342a3388a27ef682b38be66e4539723fcf5b121da0c366c940ab139657070b9d1ad92af697b6b8f38955eb8cd7f2d93d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/993ead73b55e97b8827a864d99bee3db23899bc78d8912d2eb6ed7be9157be4e4692b7bbf476988aa74a4363b9848dc8d099ac04e14535c818f2a6722eb07d18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/23954b06521224c629cb77279e7b15afe5258ec617bed37189c80788b7c2b5edc3fe5839e6302c237eaae367ef45e90ad13819a9cd76f6ae3a88c2953117bf36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a3bc5037f554f48fe77c55d7fa83dcfc7b971333ca0a8cc61e1603f44c1c6436a54bb38f9742b0134358208738abf10c66c60ee6a3baf09db38e29456f96e0bb"} 10:04:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:04:16 INFO - Copying logs to upload dir... 10:04:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:04:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2486.562812 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 26 secs) (at 2017-05-22 10:04:16.709570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 10:04:16.713377) ========= 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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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/Jamun/sha512/1d6a61ab6378c5ffcc21d2099a34b1d6342a3388a27ef682b38be66e4539723fcf5b121da0c366c940ab139657070b9d1ad92af697b6b8f38955eb8cd7f2d93d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/993ead73b55e97b8827a864d99bee3db23899bc78d8912d2eb6ed7be9157be4e4692b7bbf476988aa74a4363b9848dc8d099ac04e14535c818f2a6722eb07d18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/23954b06521224c629cb77279e7b15afe5258ec617bed37189c80788b7c2b5edc3fe5839e6302c237eaae367ef45e90ad13819a9cd76f6ae3a88c2953117bf36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a3bc5037f554f48fe77c55d7fa83dcfc7b971333ca0a8cc61e1603f44c1c6436a54bb38f9742b0134358208738abf10c66c60ee6a3baf09db38e29456f96e0bb"} build_url:https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/ZfF-dMlGSLaOhCaBqsaVBg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/1d6a61ab6378c5ffcc21d2099a34b1d6342a3388a27ef682b38be66e4539723fcf5b121da0c366c940ab139657070b9d1ad92af697b6b8f38955eb8cd7f2d93d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/993ead73b55e97b8827a864d99bee3db23899bc78d8912d2eb6ed7be9157be4e4692b7bbf476988aa74a4363b9848dc8d099ac04e14535c818f2a6722eb07d18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/23954b06521224c629cb77279e7b15afe5258ec617bed37189c80788b7c2b5edc3fe5839e6302c237eaae367ef45e90ad13819a9cd76f6ae3a88c2953117bf36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/a3bc5037f554f48fe77c55d7fa83dcfc7b971333ca0a8cc61e1603f44c1c6436a54bb38f9742b0134358208738abf10c66c60ee6a3baf09db38e29456f96e0bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 10:04:16.745982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 10:04:16.746331) ========= 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.0m2ZYw5Ypn/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.cRwdIHNZMj/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.005060 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 10:04:16.796111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 10:04:16.796421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 10:04:16.796730) ========= ========= Total master_lag: 0.17 =========