builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1492556310.39 results: success (0) buildid: 20170418142421 builduid: e7434123ac41488f9037f65a3a2aeb7f revision: 1a81aadc2510f227792cd4d789c8333329468351 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.389959) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.390452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.390731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.417583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.417968) ========= 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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-18 15:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.9M=0.001s 2017-04-18 15:58:30 (20.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131334 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.575066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.575544) ========= 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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.029069 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:30.627464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 15:58:30.627827) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1a81aadc2510f227792cd4d789c8333329468351 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1a81aadc2510f227792cd4d789c8333329468351 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-18 15:58:30,739 truncating revision to first 12 chars 2017-04-18 15:58:30,739 Setting DEBUG logging. 2017-04-18 15:58:30,739 attempt 1/10 2017-04-18 15:58:30,739 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1a81aadc2510?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 15:58:32,534 unpacking tar archive at: mozilla-central-1a81aadc2510/testing/mozharness/ program finished with exit code 0 elapsedTime=2.073913 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 15:58:32.725438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:32.725989) ========= script_repo_revision: 1a81aadc2510f227792cd4d789c8333329468351 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:32.726695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:32.727182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 15:58:32.747879) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-18 15:58:32.748292) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:58:32 INFO - MultiFileLogger online at 20170418 15:58:32 in /builds/slave/test 15:58:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:58:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:32 INFO - {'append_to_log': False, 15:58:32 INFO - 'base_work_dir': '/builds/slave/test', 15:58:32 INFO - 'blob_upload_branch': 'Firefox', 15:58:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:32 INFO - 'branch': 'Firefox', 15:58:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:32 INFO - 'config_files': ('talos/mac_config.py',), 15:58:32 INFO - 'default_actions': ('clobber', 15:58:32 INFO - 'read-buildbot-config', 15:58:32 INFO - 'download-and-extract', 15:58:32 INFO - 'populate-webroot', 15:58:32 INFO - 'create-virtualenv', 15:58:32 INFO - 'install', 15:58:32 INFO - 'run-tests'), 15:58:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:32 INFO - 'download_minidump_stackwalk': True, 15:58:32 INFO - 'download_symbols': 'ondemand', 15:58:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:32 INFO - 'gecko_profile': False, 15:58:32 INFO - 'gecko_profile_interval': 0, 15:58:32 INFO - 'installer_path': 'installer.exe', 15:58:32 INFO - 'log_level': 'info', 15:58:32 INFO - 'log_name': 'talos', 15:58:32 INFO - 'log_to_console': True, 15:58:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:58:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:58:32 INFO - 'opt_config_files': (), 15:58:32 INFO - 'pip_index': False, 15:58:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:58:32 INFO - 'cmd': ('bash', 15:58:32 INFO - '-c', 15:58:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:58:32 INFO - 'enabled': True, 15:58:32 INFO - 'halt_on_failure': False, 15:58:32 INFO - 'name': 'check_screen_resolution'},), 15:58:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:58:32 INFO - 'cmd': ('bash', 15:58:32 INFO - '-c', 15:58:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:58:32 INFO - 'enabled': True, 15:58:32 INFO - 'halt_on_failure': False, 15:58:32 INFO - 'name': 'check_screen_resolution'},), 15:58:32 INFO - 'run_cmd_checks_enabled': True, 15:58:32 INFO - 'suite': 'dromaeojs', 15:58:32 INFO - 'system_bits': '32', 15:58:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:32 INFO - 'title': 't-yosemite-r7-0082', 15:58:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:32 INFO - 'use_talos_json': True, 15:58:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:32 INFO - 'work_dir': 'build'} 15:58:32 INFO - [mozharness: 2017-04-18 22:58:32.962068Z] Running clobber step. 15:58:32 INFO - Running pre-action listener: _resource_record_pre_action 15:58:32 INFO - Running main action method: clobber 15:58:32 INFO - rmtree: /builds/slave/test/build 15:58:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:35 INFO - Running post-action listener: _resource_record_post_action 15:58:35 INFO - [mozharness: 2017-04-18 22:58:35.393506Z] Finished clobber step (success) 15:58:35 INFO - [mozharness: 2017-04-18 22:58:35.393670Z] Running read-buildbot-config step. 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: read_buildbot_config 15:58:35 INFO - Using buildbot properties: 15:58:35 INFO - { 15:58:35 INFO - "project": "", 15:58:35 INFO - "product": "firefox", 15:58:35 INFO - "script_repo_revision": "production", 15:58:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:58:35 INFO - "repository": "", 15:58:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:58:35 INFO - "buildid": "20170418142421", 15:58:35 INFO - "pgo_build": "False", 15:58:35 INFO - "basedir": "/builds/slave/test", 15:58:35 INFO - "buildnumber": 31, 15:58:35 INFO - "slavename": "t-yosemite-r7-0082", 15:58:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:58:35 INFO - "platform": "yosemite_r7", 15:58:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:58:35 INFO - "branch": "mozilla-central", 15:58:35 INFO - "repo_path": "mozilla-central", 15:58:35 INFO - "revision": "1a81aadc2510f227792cd4d789c8333329468351", 15:58:35 INFO - "stage_platform": "macosx64", 15:58:35 INFO - "builduid": "e7434123ac41488f9037f65a3a2aeb7f", 15:58:35 INFO - "slavebuilddir": "test" 15:58:35 INFO - } 15:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:58:35 INFO - Running post-action listener: _resource_record_post_action 15:58:35 INFO - [mozharness: 2017-04-18 22:58:35.396839Z] Finished read-buildbot-config step (success) 15:58:35 INFO - [mozharness: 2017-04-18 22:58:35.396990Z] Running download-and-extract step. 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: download_and_extract 15:58:35 INFO - mkdir: /builds/slave/test/build/tests 15:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:35 INFO - trying https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:58:35 INFO - Downloading https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:58:36 INFO - Downloaded 1325 bytes. 15:58:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:58:36 INFO - Using the following test package requirements: 15:58:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:58:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:58:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:58:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:58:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'jsshell-mac.zip'], 15:58:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:58:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:58:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:58:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:58:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:58:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:58:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:58:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:58:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:58:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:58:36 INFO - Fetch https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:58:37 INFO - Expected file size: 52632879 15:58:37 INFO - Obtained file size: 52632879 15:58:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:58:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:58:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:58:54 INFO - Fetch https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:58:55 INFO - Expected file size: 52632879 15:58:55 INFO - Obtained file size: 52632879 15:59:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:59:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:59:11 INFO - Fetch https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:59:12 INFO - Expected file size: 14408802 15:59:12 INFO - Obtained file size: 14408802 15:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:12 INFO - trying https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:59:12 INFO - Downloading https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:59:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:59:14 INFO - Downloaded 71428224 bytes. 15:59:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:59:14 INFO - mkdir: /builds/slave/test/properties 15:59:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:59:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:59:14 INFO - Contents: 15:59:14 INFO - build_url:https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:59:15 INFO - Running post-action listener: _resource_record_post_action 15:59:15 INFO - Running post-action listener: set_extra_try_arguments 15:59:15 INFO - [mozharness: 2017-04-18 22:59:15.399408Z] Finished download-and-extract step (success) 15:59:15 INFO - [mozharness: 2017-04-18 22:59:15.399534Z] Running populate-webroot step. 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: populate_webroot 15:59:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:15 INFO - '--tppagecycles', 15:59:15 INFO - '7'], 15:59:15 INFO - 'tests': ['tsvgm']}}, 15:59:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:59:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:59:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['damp', 'tps']}, 15:59:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'tests': ['damp', 'tps']}, 15:59:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['dromaeo_dom']}, 15:59:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:59:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:59:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['a11yr', 15:59:15 INFO - 'ts_paint', 15:59:15 INFO - 'tpaint', 15:59:15 INFO - 'sessionrestore', 15:59:15 INFO - 'sessionrestore_no_auto_restore', 15:59:15 INFO - 'tabpaint']}, 15:59:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:59:15 INFO - 'ts_paint', 15:59:15 INFO - 'tpaint', 15:59:15 INFO - 'sessionrestore', 15:59:15 INFO - 'sessionrestore_no_auto_restore', 15:59:15 INFO - 'tabpaint']}, 15:59:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:59:15 INFO - 'ts_paint', 15:59:15 INFO - 'tpaint', 15:59:15 INFO - 'sessionrestore', 15:59:15 INFO - 'sessionrestore_no_auto_restore', 15:59:15 INFO - 'tabpaint']}, 15:59:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:59:15 INFO - 'ts_paint', 15:59:15 INFO - 'tpaint', 15:59:15 INFO - 'sessionrestore', 15:59:15 INFO - 'sessionrestore_no_auto_restore', 15:59:15 INFO - 'tabpaint']}, 15:59:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['a11yr', 15:59:15 INFO - 'ts_paint', 15:59:15 INFO - 'tpaint', 15:59:15 INFO - 'sessionrestore', 15:59:15 INFO - 'sessionrestore_no_auto_restore', 15:59:15 INFO - 'tabpaint']}, 15:59:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['a11yr', 15:59:15 INFO - 'ts_paint', 15:59:15 INFO - 'tpaint', 15:59:15 INFO - 'sessionrestore', 15:59:15 INFO - 'sessionrestore_no_auto_restore', 15:59:15 INFO - 'tabpaint']}, 15:59:15 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:59:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:59:15 INFO - 'bloom_basic_ref']}, 15:59:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['tsvgx', 15:59:15 INFO - 'tsvgr_opacity', 15:59:15 INFO - 'tart', 15:59:15 INFO - 'tscrollx', 15:59:15 INFO - 'cart', 15:59:15 INFO - 'tsvg_static']}, 15:59:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:59:15 INFO - 'tsvgr_opacity', 15:59:15 INFO - 'tart', 15:59:15 INFO - 'tscrollx', 15:59:15 INFO - 'cart', 15:59:15 INFO - 'tsvg_static']}, 15:59:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'talos_options': ['--disable-e10s'], 15:59:15 INFO - 'tests': ['tp5o']}, 15:59:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:59:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'talos_options': ['--disable-e10s', 15:59:15 INFO - '--xperf_path', 15:59:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:15 INFO - 'tests': ['tp5n']}, 15:59:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:59:15 INFO - 'talos_options': ['--xperf_path', 15:59:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:15 INFO - 'tests': ['tp5n']}}, 15:59:15 INFO - 'talos.zip': {'path': '', 15:59:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:15 INFO - Running post-action listener: _resource_record_post_action 15:59:15 INFO - [mozharness: 2017-04-18 22:59:15.418671Z] Finished populate-webroot step (success) 15:59:15 INFO - [mozharness: 2017-04-18 22:59:15.418803Z] Running create-virtualenv step. 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: create_virtualenv 15:59:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:59:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:59:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:59:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:15 INFO - Using real prefix '/tools/python27' 15:59:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:59:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:19 INFO - Installing pip.................done. 15:59:19 INFO - Return code: 0 15:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:59:19 INFO - Reading from file tmpfile_stdout 15:59:19 INFO - Output received: 15:59:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:59:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:19 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:19 INFO - 'HOME': '/Users/cltbld', 15:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:19 INFO - 'LOGNAME': 'cltbld', 15:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:19 INFO - 'MOZ_NO_REMOTE': '1', 15:59:19 INFO - 'NO_EM_RESTART': '1', 15:59:19 INFO - 'PAGER': '/bin/cat', 15:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:19 INFO - 'PWD': '/builds/slave/test', 15:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:19 INFO - 'SHELL': '/bin/bash', 15:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:19 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:19 INFO - 'USER': 'cltbld', 15:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:19 INFO - 'XPC_FLAGS': '0x0', 15:59:19 INFO - 'XPC_SERVICE_NAME': '0', 15:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:59:19 INFO - Cleaning up... 15:59:19 INFO - Return code: 0 15:59:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:19 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:19 INFO - 'HOME': '/Users/cltbld', 15:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:19 INFO - 'LOGNAME': 'cltbld', 15:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:19 INFO - 'MOZ_NO_REMOTE': '1', 15:59:19 INFO - 'NO_EM_RESTART': '1', 15:59:19 INFO - 'PAGER': '/bin/cat', 15:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:19 INFO - 'PWD': '/builds/slave/test', 15:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:19 INFO - 'SHELL': '/bin/bash', 15:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:19 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:19 INFO - 'USER': 'cltbld', 15:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:19 INFO - 'XPC_FLAGS': '0x0', 15:59:19 INFO - 'XPC_SERVICE_NAME': '0', 15:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:20 INFO - Downloading/unpacking psutil>=3.1.1 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:23 INFO - Installing collected packages: psutil 15:59:23 INFO - Running setup.py install for psutil 15:59:23 INFO - building 'psutil._psutil_osx' extension 15:59:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:59:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:59:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:59:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:59:24 INFO - building 'psutil._psutil_posix' extension 15:59:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:59:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:59:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:59:24 INFO - ^ 15:59:24 INFO - 1 warning generated. 15:59:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:59:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:24 INFO - Successfully installed psutil 15:59:24 INFO - Cleaning up... 15:59:24 INFO - Return code: 0 15:59:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:24 INFO - 'HOME': '/Users/cltbld', 15:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:24 INFO - 'LOGNAME': 'cltbld', 15:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:24 INFO - 'MOZ_NO_REMOTE': '1', 15:59:24 INFO - 'NO_EM_RESTART': '1', 15:59:24 INFO - 'PAGER': '/bin/cat', 15:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:24 INFO - 'PWD': '/builds/slave/test', 15:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:24 INFO - 'SHELL': '/bin/bash', 15:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:24 INFO - 'USER': 'cltbld', 15:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:24 INFO - 'XPC_FLAGS': '0x0', 15:59:24 INFO - 'XPC_SERVICE_NAME': '0', 15:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:59:27 INFO - Installing collected packages: mozsystemmonitor 15:59:27 INFO - Running setup.py install for mozsystemmonitor 15:59:27 INFO - Successfully installed mozsystemmonitor 15:59:27 INFO - Cleaning up... 15:59:28 INFO - Return code: 0 15:59:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:28 INFO - 'HOME': '/Users/cltbld', 15:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:28 INFO - 'LOGNAME': 'cltbld', 15:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:28 INFO - 'MOZ_NO_REMOTE': '1', 15:59:28 INFO - 'NO_EM_RESTART': '1', 15:59:28 INFO - 'PAGER': '/bin/cat', 15:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:28 INFO - 'PWD': '/builds/slave/test', 15:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:28 INFO - 'SHELL': '/bin/bash', 15:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:28 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:28 INFO - 'USER': 'cltbld', 15:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:28 INFO - 'XPC_FLAGS': '0x0', 15:59:28 INFO - 'XPC_SERVICE_NAME': '0', 15:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:28 INFO - Downloading/unpacking jsonschema==2.5.1 15:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:32 INFO - warning: no files found matching '*.txt' 15:59:32 INFO - no previously-included directories found matching 'build' 15:59:32 INFO - no previously-included directories found matching 'dist' 15:59:32 INFO - no previously-included directories found matching '.git*' 15:59:32 INFO - Installing collected packages: jsonschema, functools32 15:59:32 INFO - Running setup.py install for functools32 15:59:32 INFO - warning: no files found matching '*.txt' 15:59:32 INFO - no previously-included directories found matching 'build' 15:59:32 INFO - no previously-included directories found matching 'dist' 15:59:32 INFO - no previously-included directories found matching '.git*' 15:59:32 INFO - Successfully installed jsonschema functools32 15:59:32 INFO - Cleaning up... 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:32 INFO - 'HOME': '/Users/cltbld', 15:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PAGER': '/bin/cat', 15:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - 'XPC_FLAGS': '0x0', 15:59:32 INFO - 'XPC_SERVICE_NAME': '0', 15:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:59:33 INFO - Cleaning up... 15:59:33 INFO - Return code: 0 15:59:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:33 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:33 INFO - 'HOME': '/Users/cltbld', 15:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:33 INFO - 'LOGNAME': 'cltbld', 15:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:33 INFO - 'MOZ_NO_REMOTE': '1', 15:59:33 INFO - 'NO_EM_RESTART': '1', 15:59:33 INFO - 'PAGER': '/bin/cat', 15:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:33 INFO - 'PWD': '/builds/slave/test', 15:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:33 INFO - 'SHELL': '/bin/bash', 15:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:33 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:33 INFO - 'USER': 'cltbld', 15:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:33 INFO - 'XPC_FLAGS': '0x0', 15:59:33 INFO - 'XPC_SERVICE_NAME': '0', 15:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:33 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:35 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:37 INFO - Downloading docopt-0.6.1.tar.gz 15:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:37 INFO - Running setup.py install for blobuploader 15:59:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:37 INFO - Running setup.py install for requests 15:59:37 INFO - Running setup.py install for docopt 15:59:38 INFO - Successfully installed blobuploader requests docopt 15:59:38 INFO - Cleaning up... 15:59:38 INFO - Return code: 0 15:59:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:38 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:38 INFO - 'HOME': '/Users/cltbld', 15:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:38 INFO - 'LOGNAME': 'cltbld', 15:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:38 INFO - 'MOZ_NO_REMOTE': '1', 15:59:38 INFO - 'NO_EM_RESTART': '1', 15:59:38 INFO - 'PAGER': '/bin/cat', 15:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:38 INFO - 'PWD': '/builds/slave/test', 15:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:38 INFO - 'SHELL': '/bin/bash', 15:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:38 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:38 INFO - 'USER': 'cltbld', 15:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:38 INFO - 'XPC_FLAGS': '0x0', 15:59:38 INFO - 'XPC_SERVICE_NAME': '0', 15:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-T3w49T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-g2vac7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_hFa6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-x3RZH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-EXRIDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-svcQO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-GSRMWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-lB_MCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-PgSwSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-kb7pyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-W1iOEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Q3_SAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-GEDCIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6ZpZ5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-9eTnCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-LcM4S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-YPDrq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:40 INFO - Running setup.py install for manifestparser 15:59:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:40 INFO - Running setup.py install for mozcrash 15:59:40 INFO - Running setup.py install for mozdebug 15:59:40 INFO - Running setup.py install for mozdevice 15:59:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:40 INFO - Running setup.py install for mozfile 15:59:40 INFO - Running setup.py install for mozhttpd 15:59:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Running setup.py install for mozinfo 15:59:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Running setup.py install for mozInstall 15:59:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Running setup.py install for mozleak 15:59:41 INFO - Running setup.py install for mozlog 15:59:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Running setup.py install for moznetwork 15:59:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:41 INFO - Running setup.py install for mozprocess 15:59:42 INFO - Running setup.py install for mozprofile 15:59:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozrunner 15:59:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozscreenshot 15:59:42 INFO - Running setup.py install for moztest 15:59:42 INFO - Running setup.py install for mozversion 15:59:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:42 INFO - Cleaning up... 15:59:42 INFO - Return code: 0 15:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:42 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:42 INFO - 'HOME': '/Users/cltbld', 15:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:42 INFO - 'LOGNAME': 'cltbld', 15:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:42 INFO - 'MOZ_NO_REMOTE': '1', 15:59:42 INFO - 'NO_EM_RESTART': '1', 15:59:42 INFO - 'PAGER': '/bin/cat', 15:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:42 INFO - 'PWD': '/builds/slave/test', 15:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:42 INFO - 'SHELL': '/bin/bash', 15:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:42 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:42 INFO - 'USER': 'cltbld', 15:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:42 INFO - 'XPC_FLAGS': '0x0', 15:59:42 INFO - 'XPC_SERVICE_NAME': '0', 15:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-b4KDDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-xB4lxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-NdPmLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-4BEO5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-iG72NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Rx1ypP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mfwLEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-NXU5Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-pUCjBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-KpR9hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-G8Pyiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Gzmcui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-WPlP56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-n6JXtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-VNTCZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QDcGrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-PbYFBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:44 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:44 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:47 INFO - Downloading blessings-1.6.tar.gz 15:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:47 INFO - Installing collected packages: blessings 15:59:47 INFO - Running setup.py install for blessings 15:59:47 INFO - Successfully installed blessings 15:59:47 INFO - Cleaning up... 15:59:47 INFO - Return code: 0 15:59:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:48 INFO - Reading from file tmpfile_stdout 15:59:48 INFO - Current package versions: 15:59:48 INFO - blessings == 1.6 15:59:48 INFO - blobuploader == 1.2.4 15:59:48 INFO - docopt == 0.6.1 15:59:48 INFO - functools32 == 3.2.3-2 15:59:48 INFO - jsonschema == 2.5.1 15:59:48 INFO - manifestparser == 1.1 15:59:48 INFO - mozInstall == 1.12 15:59:48 INFO - mozcrash == 1.0 15:59:48 INFO - mozdebug == 0.1 15:59:48 INFO - mozdevice == 0.50 15:59:48 INFO - mozfile == 1.2 15:59:48 INFO - mozhttpd == 0.7 15:59:48 INFO - mozinfo == 0.9 15:59:48 INFO - mozleak == 0.1 15:59:48 INFO - mozlog == 3.4 15:59:48 INFO - moznetwork == 0.27 15:59:48 INFO - mozprocess == 0.25 15:59:48 INFO - mozprofile == 0.28 15:59:48 INFO - mozrunner == 6.13 15:59:48 INFO - mozscreenshot == 0.1 15:59:48 INFO - mozsystemmonitor == 0.3 15:59:48 INFO - moztest == 0.8 15:59:48 INFO - mozversion == 1.4 15:59:48 INFO - psutil == 3.1.1 15:59:48 INFO - requests == 1.2.3 15:59:48 INFO - wsgiref == 0.1.2 15:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:48 INFO - 'HOME': '/Users/cltbld', 15:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:48 INFO - 'LOGNAME': 'cltbld', 15:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:48 INFO - 'MOZ_NO_REMOTE': '1', 15:59:48 INFO - 'NO_EM_RESTART': '1', 15:59:48 INFO - 'PAGER': '/bin/cat', 15:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:48 INFO - 'PWD': '/builds/slave/test', 15:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:48 INFO - 'SHELL': '/bin/bash', 15:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:48 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:48 INFO - 'USER': 'cltbld', 15:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:48 INFO - 'XPC_FLAGS': '0x0', 15:59:48 INFO - 'XPC_SERVICE_NAME': '0', 15:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:48 INFO - Cleaning up... 15:59:48 INFO - Return code: 0 15:59:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 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 0x1081b0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1081b3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f334d2000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, '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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 15:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:48 INFO - 'HOME': '/Users/cltbld', 15:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:48 INFO - 'LOGNAME': 'cltbld', 15:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:48 INFO - 'MOZ_NO_REMOTE': '1', 15:59:48 INFO - 'NO_EM_RESTART': '1', 15:59:48 INFO - 'PAGER': '/bin/cat', 15:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:48 INFO - 'PWD': '/builds/slave/test', 15:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:48 INFO - 'SHELL': '/bin/bash', 15:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 15:59:48 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 15:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:48 INFO - 'USER': 'cltbld', 15:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:48 INFO - 'XPC_FLAGS': '0x0', 15:59:48 INFO - 'XPC_SERVICE_NAME': '0', 15:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:59:48 INFO - Cleaning up... 15:59:48 INFO - Return code: 0 15:59:48 INFO - Running post-action listener: _resource_record_post_action 15:59:48 INFO - Running post-action listener: _start_resource_monitoring 15:59:48 INFO - Starting resource monitoring. 15:59:48 INFO - [mozharness: 2017-04-18 22:59:48.639533Z] Finished create-virtualenv step (success) 15:59:48 INFO - [mozharness: 2017-04-18 22:59:48.640556Z] Running install step. 15:59:48 INFO - Running pre-action listener: _resource_record_pre_action 15:59:48 INFO - Running main action method: install 15:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:48 INFO - Reading from file tmpfile_stdout 15:59:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:49 INFO - Reading from file tmpfile_stdout 15:59:49 INFO - Output received: 15:59:49 INFO - Usage: mozinstall [options] installer 15:59:49 INFO - Options: 15:59:49 INFO - -h, --help show this help message and exit 15:59:49 INFO - -d DEST, --destination=DEST 15:59:49 INFO - Directory to install application into. [default: 15:59:49 INFO - "/builds/slave/test"] 15:59:49 INFO - --app=APP Application being installed. [default: firefox] 15:59:49 INFO - mkdir: /builds/slave/test/build/application 15:59:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:00:09 INFO - Reading from file tmpfile_stdout 16:00:09 INFO - Output received: 16:00:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:00:09 INFO - Running post-action listener: _resource_record_post_action 16:00:09 INFO - [mozharness: 2017-04-18 23:00:09.222714Z] Finished install step (success) 16:00:09 INFO - [mozharness: 2017-04-18 23:00:09.222880Z] Running run-tests step. 16:00:09 INFO - Running pre-action listener: _resource_record_pre_action 16:00:09 INFO - Running main action method: run_tests 16:00:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:00:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:00:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:00:09 INFO - 2017-04-18 16:00:09.237 screenresolution[1623:7369] starting screenresolution argv=screenresolution get 16:00:09 INFO - 2017-04-18 16:00:09.240 screenresolution[1623:7369] Display 0: 1600x1200x32@60 16:00:09 INFO - 2017-04-18 16:00:09.246 screenresolution[1624:7371] starting screenresolution argv=screenresolution list 16:00:09 INFO - Available Modes on Display 0 16:00:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:00:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:00:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:00:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:00:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:00:09 INFO - Intel Iris: 16:00:09 INFO - Chipset Model: Intel Iris 16:00:09 INFO - Type: GPU 16:00:09 INFO - Bus: Built-In 16:00:09 INFO - VRAM (Dynamic, Max): 1536 MB 16:00:09 INFO - Vendor: Intel (0x8086) 16:00:09 INFO - Device ID: 0x0a2e 16:00:09 INFO - Revision ID: 0x0009 16:00:09 INFO - Displays: 16:00:09 INFO - Display: 16:00:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:00:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:00:09 INFO - Display Serial Number: 1600x1200 60 16:00:09 INFO - Main Display: Yes 16:00:09 INFO - Mirror: Off 16:00:09 INFO - Online: Yes 16:00:09 INFO - Rotation: Supported 16:00:09 INFO - Return code: 0 16:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:00:09 INFO - Python 2.7.3 16:00:09 INFO - Return code: 0 16:00:09 INFO - grabbing minidump binary from tooltool 16:00: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')]} 16:00:09 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 0x107f8ed30>, '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 0x107eb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f83be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:00:09 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 16:00:09 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 16:00:09 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 16:00:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:09 INFO - Return code: 0 16:00:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:00:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:00:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:00:09 INFO - ENV: RUST_BACKTRACE is now 1 16:00:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:00:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:00:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 16:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 16:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HWQcqDpPsT/Render', 16:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:09 INFO - 'HOME': '/Users/cltbld', 16:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:09 INFO - 'LOGNAME': 'cltbld', 16:00:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:00:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:09 INFO - 'MOZ_NO_REMOTE': '1', 16:00:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:00:09 INFO - 'NO_EM_RESTART': '1', 16:00:09 INFO - 'PAGER': '/bin/cat', 16:00:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:09 INFO - 'PWD': '/builds/slave/test', 16:00:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:09 INFO - 'RUST_BACKTRACE': '1', 16:00:09 INFO - 'SHELL': '/bin/bash', 16:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3JEFIhKTSQ/Listeners', 16:00:09 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:09 INFO - 'USER': 'cltbld', 16:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:09 INFO - 'XPC_FLAGS': '0x0', 16:00:09 INFO - 'XPC_SERVICE_NAME': '0', 16:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 16:00:09 INFO - mozversion application_buildid: 20170418142421 16:00:09 INFO - mozversion application_changeset: 1a81aadc2510f227792cd4d789c8333329468351 16:00:09 INFO - mozversion application_display_name: Nightly 16:00:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:09 INFO - mozversion application_name: Firefox 16:00:09 INFO - mozversion application_remotingname: firefox 16:00:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:00:09 INFO - mozversion application_vendor: Mozilla 16:00:09 INFO - mozversion application_version: 55.0a1 16:00:09 INFO - mozversion platform_buildid: 20170418142421 16:00:09 INFO - mozversion platform_changeset: 1a81aadc2510f227792cd4d789c8333329468351 16:00:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:00:09 INFO - mozversion platform_version: 55.0a1 16:00:09 INFO - using testdate: 1492556409 16:00:09 INFO - actual date: 1492556409 16:00:09 INFO - starting webserver on 'localhost:49250' 16:00:09 INFO - SUITE-START | Running 2 tests 16:00:09 INFO - TEST-START | dromaeo_css 16:00:09 INFO - operating with platform_type : mac_ 16:00:09 INFO - Initialising browser for dromaeo_css test... 16:00:09 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpSYoNkZ/profile http://localhost:49250/getInfo.html) 16:00:12 INFO - PID 1634 | __metrics Screen width/height:1600/1200 16:00:12 INFO - PID 1634 | colorDepth:24 16:00:12 INFO - PID 1634 | Browser inner width/height: 1024/689 16:00:12 INFO - PID 1634 | __metrics 16:00:12 INFO - PID 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:00:12 INFO - PID 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:00:13 INFO - TEST-INFO | 1634: exit 0 16:00:13 INFO - Browser initialized. 16:00:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:13 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpSYoNkZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:25 INFO - PID 1636 | RSS: Main: 240623616 16:00:25 INFO - PID 1636 | 16:03:30 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 16:03:32 INFO - PID 1636 | RSS: Main: 413155328 16:03:32 INFO - PID 1636 | 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:05:15 INFO - PID 1636 | 16:05:15 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:05:15 INFO - PID 1636 | Full stack: 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:05:15 INFO - PID 1636 | 16:05:15 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:05:15 INFO - PID 1636 | Full stack: 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:05:15 INFO - PID 1636 | 16:05:15 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:05:15 INFO - PID 1636 | Full stack: 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | ************************* 16:05:15 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 16:05:15 INFO - PID 1636 | 16:05:15 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:05:15 INFO - PID 1636 | Full stack: 16:05:15 INFO - PID 1636 | ************************* 16:06:34 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 16:06:35 INFO - PID 1636 | RSS: Main: 368775168 16:06:35 INFO - PID 1636 | 16:09:37 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 16:09:38 INFO - PID 1636 | RSS: Main: 359833600 16:09:38 INFO - PID 1636 | 16:12:40 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 16:12:41 INFO - PID 1636 | RSS: Main: 326615040 16:12:41 INFO - PID 1636 | 16:15:44 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 16:15:45 INFO - PID 1636 | RSS: Main: 335290368 16:15:45 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 16:18:48 INFO - PID 1636 | RSS: Main: 374198272 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | __start_tp_report 16:18:48 INFO - PID 1636 | _x_x_mozilla_page_load 16:18:48 INFO - PID 1636 | _x_x_mozilla_page_load_details 16:18:48 INFO - PID 1636 | |i|pagename|runs| 16:18:48 INFO - PID 1636 | |0;dojo.html;3221.822799746014;3511.9824400878006;3537.964620353796;3548.8403021864015;3601.585817630973;5958.7616495340135;6111.969440152804;6131.938680613192;6132.478739307158;6169.537284703642;6041.788537401192;6054.576179667425;6095.922000763714;6108.69456527174;6115.327313995468;5324.094903866333;5329.360476742796;5330.333708286465;5340.465953404668;5542.057850165462;610.8756001406587;5446.863828404302;5448.210009548613;5458.5087342139195;5459.563234941215;4715.221988371914;5272.288241087443;5296.311479507659;5357.196420536911;5360.865978350573;5342.492463215988;5346.893062138774;5347.54545863602;5355.062863998784;5379.865503362408;5186.325777648882;5348.572114230852;5350.678959262418;5361.758720857571;5380.838574842761;6073.119397687355;6077.617041570647;6093.360197179277;6128.111423843562;6166.784162554289;6571.93428065718;6579.342065793382;6586;6592.637404942726;6596.637184954826;6627.73489060437;6659.766908158192;6668.766593169215;6681.131452911139;6682.632455214961;6033.818985430444;6156.107364432221;6163.599366041193;6170.074488826712;6224.813255602339;6570.047343135314;6585.111010013683;6587.934120658732;6592.967035164889;6711.060451536789;6411.326810684905;6478;6485.6108633482145;6491.67541622917;6498.025296205513;6342.904856427157;6347.5556711029785;6400.135981642512;6422.100905873182;6431.74273029083;6552;6564.146660934048;6576.44100251484;6585.275619681831;6589.868202636017;6287.685615719287;6611.438027767597;6614.503912206604;6619.569727967763;6630.701618427182;5217.530422261939;5223.425423203445;5272.9736351318;5295.4439783822145;5367.973160134175;4689.882752931136;4696.201645720235;4700.529947005272;4702.4592171899985;4776.188048031843;6213.502919766408;6219.440250377397;6235.906461403082;6245.5628106032145;6248.875022499525;6312.495000399957;6452.4515416189215;6452.774152904626;6674.432673222734;6676.399124078856;6153.892299386153;6172.197614310111;6248.4688801452385;6251.093591429218;6264.498840092781;5819.330776960704;5832.62087964281;5835.503982161564;5869.266341707286;5873.970630146822;5759.85600359986;6760.898586521304;6769.729210831511;6773.322667733188;6823.249442561413;6370.93629063722;6453.064305675557;6454.67726613658;6457.903131453126;6458.38645328693;6599.340065993362;6610.768623098168;6718.093057437183;6810.965945170243;6843.8973415399805;6520.510961677988;6533.379328963741;6550.901736473861;6568.211814582281;6588.934110658832;6657.900131498128;6660.533762636569;6670.166229221348;6677.399034086761;6680.064790929371;5857.150713146655;6297.275813281348;6363.872722545616;6450;6474.708638111202;6378.362163783585;6417.96791016042;6459.450946669585;6463.676816159267;6464.773732919325;6316.905246421215;6318;6328.651924144032;6341.49268058545;6349.68251587428;6205.720742566686;6397.456216221487;6461.06314584392;6464.903026454513;6504.902426463702;6215.378462153749;6221.96889015552;6283.622982621057;6303.905441418291;6309.053641953744 16:18:48 INFO - PID 1636 | |1;ext.html;730.4777084384664;777.7627823513828;797.0594698256058;1120.4341807387268;1141.5376772407178;27841.16476505703;28142.718572814265;37671.4349284761;37904.62095379045;38139.23721525568;40269.194616107736;40674;40684.389734154014;40688;40713;7865.567393793353;8019.35845132388;8028.5182889026555;8030.156833532454;8044.798880028017;5661;5773.220615216934;5791.739371728261;5791.7972870949525;7893.131755506918;5816.82549523515;5856.267966504187;7759.41804364672;7941.364690824749;7961.482503637245;7909.841803163933;7962.163972782832;7978.481398709066;7979;7985.081715602664;7726.690932362699;7816.765497035098;7818.179091195399;7835.804104897366;7841.255080767318;37754.43368349477;37905.24189516194;37974;37986.810065949496;38057.0485737856;3545.7517973741847;3584.229390681016;3593.5148754918014;3594.4069228577255;3600.873969411058;31028;31052.223694407596;31194.908178213653;31241.188293053736;31263;2718.768904643108;3143.1513491357205;3200.7439404847555;3206;3219.4044101841;213461;271264;271375;272603;273624;45842;47176.52823471721;50489.242661360106;50577.74711126421;50697.74651126721;53407;53408.73295633497;53456;53633.92732145335;53686.46313536815;14004.929975350058;14085.507007254902;14094.647633809236;14103.153810771386;14192.361343739556;11326.980571748418;11347.943260283811;11367.147463940237;11368.488418021208;11369.943150284362;11143;12897;13234.07361484706;13270;13341.19952802835;4702.56571745614;4788.569028787426;4798.8884890648005;4813.205821039559;4818.759062046884;802.7511471443871;933.673214374977;963.4026903319987;1004.3729158762851;1017.6896046705677;22955;23744.762552374254;23764;23789.524209515712;23797;1112.7663190730038;1113.493360520961;1149.494222542079;1151.4703236511132;1153.5962413155328;11661.88338116625;12301.753964920652;12315.076369272341;12360.629181124581;12698;252962;253946;254438;254754.72622636767;255646;50786.746066269436;50861.74569127131;50945.49054509407;51020;51028.489715102376;1483.480781726387;1488.2856229010135;1529.06726896593;1533.9309731062128;1548.3187397545043;20981.265655701976;22257.332280031624;23129.653055204522;23212.86626305427;23315.300540983797;36787;36840.44739328859;36862.44706329461;36910.8154459226;37012;236453;237837;237879;238096;238141.23717525898;33672.83163584166;33785.32429351448;33793.83103084469;33852.49221261634;33881.49177762385;41669.58330416657;41971.75353080865;42436.1512769749;42439.7878010608;42486.36270455884;30470.390592188476;31051;31943.041708748773;32035;32252.516212257306;31067.533986990664;31819.681803181673;32208.355832882742;32284;32334.676653233168;36614;37428;37972.24055518819;38194.42708359321;38202;25933;31589.684103158674;32162.83918580392;32518.34963300768;32666.673333267314;24185.87907060524;24246.393840154138;24306.149284774947;24656.630150548113;24677.01291948302 16:18:48 INFO - PID 1636 | |2;jquery.html;385.8958081318046;421.69606932838127;433.7570960262252;439.3738922036099;452.9864104076877;17363.565910852234;21202.89398553007;21994.45013874654;22900.65649015264;23000.65499017512;21976.34070977873;22547.77452225477;22856.428589285275;23130.30609081726;23594;4800.8319708810195;4876.268559716035;5285.524302812746;5447.918281225785;5504.889902201953;4689.507601701824;5416.837494875141;5487.478689524489;5509.9806535791;5515.365732940703;5226.2944502492055;5397.730113494329;5481.068218402861;5482.5613950884035;5485.506304432601;5302.92045619316;5314.5216930476445;5350.732463376835;5356.276902618136;5358.892822143535;4757.785899634525;4844.128056949748;4847.418309802811;4894.1679914414635;4959.975200124012;27383.726162738516;27945.441091178265;28064.438711225663;28086.995206366086;28367.57448638272;2220.5225876436643;2292.025888997186;2292.2206449807145;2296.552172326397;2298.333483289844;17924.731129033076;17932.820671793244;17987.73018404712;18543.629127417513;18739;2107.620628286908;2113.0913707105938;2161.103142195987;2164.7835216478384;2165.8700477971215;128078.3596082023;136780.58048548768;140149;146032;147506;11737;11952.521899123938;12517.874821251671;12559;12980.740385192243;15563.377464901503;16582.83417165837;16710.415135470445;16944.661106777796;16983.74524382135;8775.254103401156;8786.516741579275;8916.55417229149;9024.639014439348;9098.909010909938;7616.35261002821;7937.920620793833;8396.118407567239;8403.537805420638;8595.312375009984;7886.645100970355;8031.638576264082;8033.437659363905;8042.879356809653;8062.959685201537;2009.4474019644715;2023.4738967868166;2039.6124736300055;2167.5556510915226;2189.2994241842775;935.4480856294819;964.6205925526565;967.8385936875777;988.4168340679034;998.5456617239139;16312.51062468128;16608.418705345255;20349.593008139753;21011.78988210129;21366.679499807517;971.2133172130597;977.1596427072711;991.7124034030195;1002.4486532407146;1010.3634710132569;9053.230475409664;10860.67417977462;10907.509162087566;10971.780564388668;10972.286801357886;458018;463647;512945;535475.3226233844;550706;131132;136246.95629565563;138095;141374;146450;1175.9412029398495;1195.9893889663394;1222.9449674764658;1226.7423840993313;1231.6551365617463;21578.892105539373;22363.88818055899;22654;22685.8865705677;22869.19957801469;58642.82714345604;59984.700076499335;60467;60539.69730151321;61063;65149.83407052082;79961;80728.32518907038;84718.15281847103;85534.57232713797;8764.868526971974;8889.377743557889;9092.909070909207;9100.544972751204;9292.814143717223;11035.944820275847;14197.793187579171;14536.345864435914;14586.4894728684;14680.339384727926;11844;11850.525978960744;11966.700832479257;12055.51777928873;12122.75754484923;9913.702588922344;10715.732106697084;11312.377819220023;11397.259178153394;11660.358680272666;11971.401429928643;11989.160758746804;12109.455074521491;12170.45232964501;12188.939055304667;7349.228331025379;7430.888536671846;8932.28541716674;9021.278297736297;9048.140426659456;11817.586384476503;11864.584739534075;12006.579769708018;12008.939955300517;12025.398730063287 16:18:48 INFO - PID 1636 | |3;mootools.html;1389.5831250624813;1451.8838492920568;1478.7042591481702;1480.896337256392;1490.500682271439;11592.710182245448;12039.458224379901;12045.698857528545;12066.81899771503;12075.033997280218;11382.260153090065;11567.248128871617;11604.709882252926;11778.11664125192;11785.23395979263;2488.4774197418565;2530.1903390914913;2538.4669219463844;2538.6953565572157;2541.2122242104915;2450.9142180023705;2458.2423567149485;2495.36368226103;2497.1509686706518;2497.5254701606727;2444.278937713379;2523.8611876346795;2532.962005569918;2538.111660918682;2541.504406640706;2466.962995555068;2486.4032632168332;2498.750124987505;2524.596064629669;2531.4430825218424;2490.2404766546197;2495.8502489850666;2518.7229404765462;2530.266222795387;2531.5949448088218;11475.311481311148;11625.418729063598;11706.414679266003;11713.004394626467;11761.529538818437;4784.306275590055;6393.328700486475;6394.712237949303;6412.67936603168;6412.871742565169;4011;4256.276433006366;4300.118475712471;4306.332518459643;4358.825646974117;1231.9753604927942;1233.6792433967144;1315.421214665544;1315.9539416120485;1318.3671837518045;14934;15363.385464581403;15367.231638418147;16062.116583587898;16469.258883350278;4656.650751193606;5411.2153737708595;5423.918641220384;5429.728513574306;5930.673812940329;13891.235982021086;13893.166410015432;13925.582232533041;13930.512432064828;13948.72102557943;6558.901616475757;6751.932480675228;6757.425618822455;6781.694823732944;6788;5930.673812940329;6103.450689437883;6126.111713801563;6262.968685156545;6268.686565671698;3829.6936245100883;4566.949601591586;4699.17764391237;4720.433547974265;4761.6904901181315;1264.873512648746;1438.992805035968;1442.278860569715;1464.3483649775746;1469.6619777451033;704.3871831506519;787.9724209652635;800.7237503061434;817.0603805623581;821.8643923752634;6613.4709223262025;6849.315068493111;6968.965155174192;6978.337057979484;7065.364117229474;748.292863244229;943.5235206220951;952.0717300631967;953.4374718915734;953.6757502449201;3808.7143464240294;3828.904277393032;3869.690424766012;3904.4533765272886;3952.723309368374;14580.125192488485;15228;15228.543143705707;15239.161846098572;15243.618909527351;15095.32071056783;15109.622259443602;15136.394544218108;15149.621259468602;15152.393904243707;8222.917770822334;8594.140585941355;8784.253338466175;8797.780055498535;8807.251383632334;6535.509836762167;6595.934040659532;6714.764983225564;6722.529422940347;6765.221999470124;12976.351182441029;13635.79546306826;13641.795373069213;13652.795208072086;13659.521916732867;11635.592754253561;12347.567835125728;12871.420786064462;13785.793213101611;14084.22536760488;9471.052894710749;9737.318387712792;9742.9025709742;9753.02469753019;9762.36544624597;10569;10654.14766818668;10726.678199654023;10773.62292319765;10784.406857622906;8830.205281524693;8948.002419189645;9011.23404510624;9089.681861134828;9180.403273787182;6830.863382732218;8656.177663121993;8817.294616430541;8842.292616590528;8911.15344042315;8071.919280807117;8185.181481851767;8203.015638123463;8211.671533138846;8247.670093196204;5908.877313310629;5921.61509501881;6045.697715114315;6119.724612392364;6190.659513726608;5875;6018.024131977421;6065.696715164312;6192.164057852313;6250.843728906631 16:18:48 INFO - PID 1636 | |4;prototype.html;389.9298126337258;391.6338223760784;392.81930312056454;395.1523981060625;403.5339183243354;5873.647581145129;5875.794347197843;5907.704614769265;5914.2902851657755;5952.55355848311;5531.419200983899;5710.514606258463;5734.369219385874;5787.594868359217;5861.7362218700155;3907.492026036611;4436.6672499562665;4471.910561788763;4477.283634618461;4479.3952816369865;4085.9795701021453;4140.143301122216;4286.97856510717;4463.196624607569;4475.664325175609;3513.5608048993877;3629.5100161478126;3860.6332398422105;4419.62433193179;4473.194824931511;3808.5239345081864;3983.50206224222;4296.591823776736;4444.200043992097;4476.776161191944;3697.8705745299053;3741.7193710471824;3936.5866584008554;3971.7616942983514;3987.9202415951518;4670.299455081731;5203.193505006692;5748.482636562688;5778.093229234342;5823.097419899922;4363.498197707241;5265.894682106375;5324.361076670785;5326.201069839516;5329.706866122362;5145.974270128663;5442.782288708447;6240.441419018181;6275.341089185616;6315;3739.6821270192067;3755.1134575714277;4359.80380882861;4481.439820022497;4546.749928753918;4912.926306105412;5370.516653501165;5712;6044.546659000593;6541.21505419348;4198.832046718097;4683.836065737751;4694.389729335165;4711.293306004127;4711.327478744996;4776.8566942991765;4779.378680771478;4798.928016079762;4799.256579867709;4808.807647694053;4210.957890421118;4921;4939.975300123477;5088;5413.539849112791;4731.006488637356;6177.4749146322165;6290.930541807904;6342.651154186564;6355.396237357444;1595.5293188509418;1612.4759453177764;1635.803703555581;1636.1982628511944;1644.2436479219455;1113.4043286841502;1120.9775804483866;1123.7977164110375;1133.3596517967321;1139.487230746151;5872.383399743051;5891.41085891416;5895.700676736076;5899.616524925866;5903.675297858573;5936.821895343147;6144.293406258248;6478.352164783578;6492.09110724499;6500.6424646643945;5270.736463176826;5682.289713785777;5753.424657534213;5849.385814489502;5861.560382971209;2683.3828219509624;2957.4085182963063;3122.6408962969094;3359.764816462873;3393.8121657419706;5096.833845615599;5258.790478190038;6560.770373036921;6590.637514936629;6615.6030638161865;6616.569922954993;6628.966855165693;6629.303923088103;6632.403083722488;6656.068150458939;6383.872322553616;6549.279579246279;6589.275179730322;6635.535512514174;6644.302348253364;5196.68819870809;5437.510624043855;5723.141528770718;6169.938300616936;6453.354664533509;4821.46963833985;5456.306607683147;5723.227364305932;6057;6406.23125224976;6077;6500.902486462613;6594.934050659624;6616.172978377703;6618.437432818265;4165.229432554987;4416.984093658541;4663.743494107856;4679.812807487662;4683.578477937002;5783.19035335045;6156.78451254204;6436.742530298736;6478.3197764235965;6478.611283323015;5288.68267903927;5462.890742185214;5698.287714035746;6151.9384806151365;6231.813045608639;6038.1922406081385;6230.376962303914;6247.5939063960695;6247.9694099416965;6258.906116408349;5609.411011843697;6057.1519987200945;6106.3588323227195;6152.907706384318;6162.661053642093;6222.7952604409675;6244.750209991549;6268.435840774352;6282.748690052346;6297.960836462115;5785.566082543742;6000.0999850022845;6044.609739759792;6061.39386061408;6073.696315184135 16:18:48 INFO - PID 1636 | |5;yui.html;698.7379732600275;757.257887270475;819.176727388974;839.7529668442364;855.9186877246659;13541.729165416686;18057.72913406298;18185.454236389924;18734.250629974784;18811.34160304388;14156.71686566268;17155.742663860052;17671.028093454854;17735.290588376483;17747.645047099082;961.1637875048717;988.6391467114487;994.2990191914682;995.343073571443;996.1482932093065;628.1927722876105;667.5614051718554;693.4313862632644;699.0911814640972;1018.1752780247986;941.6233506597347;1002.5889385352007;1047.5809676129534;1050.9316894401877;1052.0426411965113;1039.8960103989616;1041.0630432610635;1041.406398352939;1042.4214560918688;1046.053321743823;770.630097553172;771.8417724366492;773.1842905734447;773.8839174123871;775.8293175501437;16441.342346306134;16446.424375146933;16728.58178545534;17111.31554737809;17410.30358785647;13863.376148073361;16643.91678041602;16742.58143546409;17200.397986070428;17282.740758888627;13897.583072507841;14081.85918140826;14142;14221.075630084011;14336.996410251286;3349.346877358916;3373.730101591867;3374.3420033093557;3374.645662205482;3380.509826075205;115307;117531;117746;117803;118847;10883;11048.67415910096;11976.88023119775;12321.383930803424;12339.62981110568;18377.632447350978;20029.49926251826;25192.496150076895;25258.621120682837;25394;7600.961995189989;7741.380689544823;7745.92254077452;7759.2240775921955;7773.028371453568;3945.033466800652;4007.6793856491995;4038.172174704179;4039.2527382434346;4044.0092177416723;4344.847930322487;4422.513523512475;4484.865454036384;4488.932666010012;4489.147062058199;806.1776987472745;874.1127755328347;908.5094049213483;919.2783664823082;919.8850143732034;636.9076483909807;643.3823529411724;643.9034144878306;646.7348387161242;679.2765704524666;10834.187435942336;11036.240939765059;11643.53425862973;11888.762224755457;12210.328431936328;650.6746626686656;665.2250128600224;667.9398854103154;676.0805304785488;683.6513378177166;5390.275111964213;5543.223948647193;5962.211336599003;6073;6260.311365749764;102404;104178;105992;106833.46583267034;107962;91971;92296;94025;94485.5275723617;95121;80923.97690057677;81233.18766812375;81264;82146.17853821504;83161;9691.418514889128;11408.486618102039;11938.1046421517;12051.879481205076;12263.26420414778;39217;39257.803710981265;39924.80037599793;39944.40083398693;40508;65397;70314.29685703282;70906.64546677233;71570.769361522;71741;15994.440194593133;16096.11471369086;16221.270042847864;16405.753913691064;16424.67150657004;16591.502254932373;17615.647687046443;17771;17873.821261787736;18007.09964501796;16048.438304659281;16255.918720406322;16516.587085322964;16673;16706.33174673048;14073.718525629634;16088.678226435171;16374.918125409296;16405.58986025359;17055.232514536627;16644.833551664327;16669.083200424095;16797.66404671924;16801.159942003094;16810.243539041017;11726.88273117258;11853.644390668294;11895.405229738652;11992.400379980792;12200.450979706113;12660.810087848873;12974.873167418917;12996.480140794263;12999.480020799063;13227.867721322664 16:18:48 INFO - PID 1636 | __end_tp_report 16:18:48 INFO - PID 1636 | __start_cc_report 16:18:48 INFO - PID 1636 | _x_x_mozilla_cycle_collect,1861 16:18:48 INFO - PID 1636 | __end_cc_report 16:18:48 INFO - PID 1636 | __startTimestamp1492557528263__endTimestamp 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | ------- Summary: start ------- 16:18:48 INFO - PID 1636 | Number of tests: 6 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6030.16 Median:6297.28 stddev:816.08 (13.0%) stddev-sans-first:788.29 16:18:48 INFO - PID 1636 | Values: 3221.8 3512.0 3538.0 3548.8 3601.6 5958.8 6112.0 6131.9 6132.5 6169.5 6041.8 6054.6 6095.9 6108.7 6115.3 5324.1 5329.4 5330.3 5340.5 5542.1 610.9 5446.9 5448.2 5458.5 5459.6 4715.2 5272.3 5296.3 5357.2 5360.9 5342.5 5346.9 5347.5 5355.1 5379.9 5186.3 5348.6 5350.7 5361.8 5380.8 6073.1 6077.6 6093.4 6128.1 6166.8 6571.9 6579.3 6586.0 6592.6 6596.6 6627.7 6659.8 6668.8 6681.1 6682.6 6033.8 6156.1 6163.6 6170.1 6224.8 6570.0 6585.1 6587.9 6593.0 6711.1 6411.3 6478.0 6485.6 6491.7 6498.0 6342.9 6347.6 6400.1 6422.1 6431.7 6552.0 6564.1 6576.4 6585.3 6589.9 6287.7 6611.4 6614.5 6619.6 6630.7 5217.5 5223.4 5273.0 5295.4 5368.0 4689.9 4696.2 4700.5 4702.5 4776.2 6213.5 6219.4 6235.9 6245.6 6248.9 6312.5 6452.5 6452.8 6674.4 6676.4 6153.9 6172.2 6248.5 6251.1 6264.5 5819.3 5832.6 5835.5 5869.3 5874.0 5759.9 6760.9 6769.7 6773.3 6823.2 6370.9 6453.1 6454.7 6457.9 6458.4 6599.3 6610.8 6718.1 6811.0 6843.9 6520.5 6533.4 6550.9 6568.2 6588.9 6657.9 6660.5 6670.2 6677.4 6680.1 5857.2 6297.3 6363.9 6450.0 6474.7 6378.4 6418.0 6459.5 6463.7 6464.8 6316.9 6318.0 6328.7 6341.5 6349.7 6205.7 6397.5 6461.1 6464.9 6504.9 6215.4 6222.0 6283.6 6303.9 6309.1 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:40796.14 Median:33169.75 stddev:65604.52 (197.8%) stddev-sans-first:65719.59 16:18:48 INFO - PID 1636 | Values: 730.5 777.8 797.1 1120.4 1141.5 27841.2 28142.7 37671.4 37904.6 38139.2 40269.2 40674.0 40684.4 40688.0 40713.0 7865.6 8019.4 8028.5 8030.2 8044.8 5661.0 5773.2 5791.7 5791.8 7893.1 5816.8 5856.3 7759.4 7941.4 7961.5 7909.8 7962.2 7978.5 7979.0 7985.1 7726.7 7816.8 7818.2 7835.8 7841.3 37754.4 37905.2 37974.0 37986.8 38057.0 3545.8 3584.2 3593.5 3594.4 3600.9 31028.0 31052.2 31194.9 31241.2 31263.0 2718.8 3143.2 3200.7 3206.0 3219.4 213461.0 271264.0 271375.0 272603.0 273624.0 45842.0 47176.5 50489.2 50577.7 50697.7 53407.0 53408.7 53456.0 53633.9 53686.5 14004.9 14085.5 14094.6 14103.2 14192.4 11327.0 11347.9 11367.1 11368.5 11369.9 11143.0 12897.0 13234.1 13270.0 13341.2 4702.6 4788.6 4798.9 4813.2 4818.8 802.8 933.7 963.4 1004.4 1017.7 22955.0 23744.8 23764.0 23789.5 23797.0 1112.8 1113.5 1149.5 1151.5 1153.6 11661.9 12301.8 12315.1 12360.6 12698.0 252962.0 253946.0 254438.0 254754.7 255646.0 50786.7 50861.7 50945.5 51020.0 51028.5 1483.5 1488.3 1529.1 1533.9 1548.3 20981.3 22257.3 23129.7 23212.9 23315.3 36787.0 36840.4 36862.4 36910.8 37012.0 236453.0 237837.0 237879.0 238096.0 238141.2 33672.8 33785.3 33793.8 33852.5 33881.5 41669.6 41971.8 42436.2 42439.8 42486.4 30470.4 31051.0 31943.0 32035.0 32252.5 31067.5 31819.7 32208.4 32284.0 32334.7 36614.0 37428.0 37972.2 38194.4 38202.0 25933.0 31589.7 32162.8 32518.3 32666.7 24185.9 24246.4 24306.1 24656.6 24677.0 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:34243.09 Median:2297.44 stddev:86343.94 (3758.3%) stddev-sans-first:86548.73 16:18:48 INFO - PID 1636 | Values: 385.9 421.7 433.8 439.4 453.0 17363.6 21202.9 21994.5 22900.7 23000.7 21976.3 22547.8 22856.4 23130.3 23594.0 4800.8 4876.3 5285.5 5447.9 5504.9 4689.5 5416.8 5487.5 5510.0 5515.4 5226.3 5397.7 5481.1 5482.6 5485.5 5302.9 5314.5 5350.7 5356.3 5358.9 4757.8 4844.1 4847.4 4894.2 4960.0 27383.7 27945.4 28064.4 28087.0 28367.6 2220.5 2292.0 2292.2 2296.6 2298.3 17924.7 17932.8 17987.7 18543.6 18739.0 2107.6 2113.1 2161.1 2164.8 2165.9 128078.4 136780.6 140149.0 146032.0 147506.0 11737.0 11952.5 12517.9 12559.0 12980.7 15563.4 16582.8 16710.4 16944.7 16983.7 8775.3 8786.5 8916.6 9024.6 9098.9 7616.4 7937.9 8396.1 8403.5 8595.3 7886.6 8031.6 8033.4 8042.9 8063.0 2009.4 2023.5 2039.6 2167.6 2189.3 935.4 964.6 967.8 988.4 998.5 16312.5 16608.4 20349.6 21011.8 21366.7 971.2 977.2 991.7 1002.4 1010.4 9053.2 10860.7 10907.5 10971.8 10972.3 458018.0 463647.0 512945.0 535475.3 550706.0 131132.0 136247.0 138095.0 141374.0 146450.0 1175.9 1196.0 1222.9 1226.7 1231.7 21578.9 22363.9 22654.0 22685.9 22869.2 58642.8 59984.7 60467.0 60539.7 61063.0 65149.8 79961.0 80728.3 84718.2 85534.6 8764.9 8889.4 9092.9 9100.5 9292.8 11035.9 14197.8 14536.3 14586.5 14680.3 11844.0 11850.5 11966.7 12055.5 12122.8 9913.7 10715.7 11312.4 11397.3 11660.4 11971.4 11989.2 12109.5 12170.5 12188.9 7349.2 7430.9 8932.3 9021.3 9048.1 11817.6 11864.6 12006.6 12008.9 12025.4 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7143.28 Median:3818.81 stddev:4527.55 (118.6%) stddev-sans-first:4519.61 16:18:48 INFO - PID 1636 | Values: 1389.6 1451.9 1478.7 1480.9 1490.5 11592.7 12039.5 12045.7 12066.8 12075.0 11382.3 11567.2 11604.7 11778.1 11785.2 2488.5 2530.2 2538.5 2538.7 2541.2 2450.9 2458.2 2495.4 2497.2 2497.5 2444.3 2523.9 2533.0 2538.1 2541.5 2467.0 2486.4 2498.8 2524.6 2531.4 2490.2 2495.9 2518.7 2530.3 2531.6 11475.3 11625.4 11706.4 11713.0 11761.5 4784.3 6393.3 6394.7 6412.7 6412.9 4011.0 4256.3 4300.1 4306.3 4358.8 1232.0 1233.7 1315.4 1316.0 1318.4 14934.0 15363.4 15367.2 16062.1 16469.3 4656.7 5411.2 5423.9 5429.7 5930.7 13891.2 13893.2 13925.6 13930.5 13948.7 6558.9 6751.9 6757.4 6781.7 6788.0 5930.7 6103.5 6126.1 6263.0 6268.7 3829.7 4566.9 4699.2 4720.4 4761.7 1264.9 1439.0 1442.3 1464.3 1469.7 704.4 788.0 800.7 817.1 821.9 6613.5 6849.3 6969.0 6978.3 7065.4 748.3 943.5 952.1 953.4 953.7 3808.7 3828.9 3869.7 3904.5 3952.7 14580.1 15228.0 15228.5 15239.2 15243.6 15095.3 15109.6 15136.4 15149.6 15152.4 8222.9 8594.1 8784.3 8797.8 8807.3 6535.5 6595.9 6714.8 6722.5 6765.2 12976.4 13635.8 13641.8 13652.8 13659.5 11635.6 12347.6 12871.4 13785.8 14084.2 9471.1 9737.3 9742.9 9753.0 9762.4 10569.0 10654.1 10726.7 10773.6 10784.4 8830.2 8948.0 9011.2 9089.7 9180.4 6830.9 8656.2 8817.3 8842.3 8911.2 8071.9 8185.2 8203.0 8211.7 8247.7 5908.9 5921.6 6045.7 6119.7 6190.7 5875.0 6018.0 6065.7 6192.2 6250.8 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5036.42 Median:5497.15 stddev:1523.87 (27.7%) stddev-sans-first:1487.70 16:18:48 INFO - PID 1636 | Values: 389.9 391.6 392.8 395.2 403.5 5873.6 5875.8 5907.7 5914.3 5952.6 5531.4 5710.5 5734.4 5787.6 5861.7 3907.5 4436.7 4471.9 4477.3 4479.4 4086.0 4140.1 4287.0 4463.2 4475.7 3513.6 3629.5 3860.6 4419.6 4473.2 3808.5 3983.5 4296.6 4444.2 4476.8 3697.9 3741.7 3936.6 3971.8 3987.9 4670.3 5203.2 5748.5 5778.1 5823.1 4363.5 5265.9 5324.4 5326.2 5329.7 5146.0 5442.8 6240.4 6275.3 6315.0 3739.7 3755.1 4359.8 4481.4 4546.7 4912.9 5370.5 5712.0 6044.5 6541.2 4198.8 4683.8 4694.4 4711.3 4711.3 4776.9 4779.4 4798.9 4799.3 4808.8 4211.0 4921.0 4940.0 5088.0 5413.5 4731.0 6177.5 6290.9 6342.7 6355.4 1595.5 1612.5 1635.8 1636.2 1644.2 1113.4 1121.0 1123.8 1133.4 1139.5 5872.4 5891.4 5895.7 5899.6 5903.7 5936.8 6144.3 6478.4 6492.1 6500.6 5270.7 5682.3 5753.4 5849.4 5861.6 2683.4 2957.4 3122.6 3359.8 3393.8 5096.8 5258.8 6560.8 6590.6 6615.6 6616.6 6629.0 6629.3 6632.4 6656.1 6383.9 6549.3 6589.3 6635.5 6644.3 5196.7 5437.5 5723.1 6169.9 6453.4 4821.5 5456.3 5723.2 6057.0 6406.2 6077.0 6500.9 6594.9 6616.2 6618.4 4165.2 4417.0 4663.7 4679.8 4683.6 5783.2 6156.8 6436.7 6478.3 6478.6 5288.7 5462.9 5698.3 6151.9 6231.8 6038.2 6230.4 6247.6 6248.0 6258.9 5609.4 6057.2 6106.4 6152.9 6162.7 6222.8 6244.8 6268.4 6282.7 6298.0 5785.6 6000.1 6044.6 6061.4 6073.7 16:18:48 INFO - PID 1636 | 16:18:48 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21891.17 Median:18121.59 stddev:30690.46 (169.4%) stddev-sans-first:30735.30 16:18:48 INFO - PID 1636 | Values: 698.7 757.3 819.2 839.8 855.9 13541.7 18057.7 18185.5 18734.3 18811.3 14156.7 17155.7 17671.0 17735.3 17747.6 961.2 988.6 994.3 995.3 996.1 628.2 667.6 693.4 699.1 1018.2 941.6 1002.6 1047.6 1050.9 1052.0 1039.9 1041.1 1041.4 1042.4 1046.1 770.6 771.8 773.2 773.9 775.8 16441.3 16446.4 16728.6 17111.3 17410.3 13863.4 16643.9 16742.6 17200.4 17282.7 13897.6 14081.9 14142.0 14221.1 14337.0 3349.3 3373.7 3374.3 3374.6 3380.5 115307.0 117531.0 117746.0 117803.0 118847.0 10883.0 11048.7 11976.9 12321.4 12339.6 18377.6 20029.5 25192.5 25258.6 25394.0 7601.0 7741.4 7745.9 7759.2 7773.0 3945.0 4007.7 4038.2 4039.3 4044.0 4344.8 4422.5 4484.9 4488.9 4489.1 806.2 874.1 908.5 919.3 919.9 636.9 643.4 643.9 646.7 679.3 10834.2 11036.2 11643.5 11888.8 12210.3 650.7 665.2 667.9 676.1 683.7 5390.3 5543.2 5962.2 6073.0 6260.3 102404.0 104178.0 105992.0 106833.5 107962.0 91971.0 92296.0 94025.0 94485.5 95121.0 80924.0 81233.2 81264.0 82146.2 83161.0 9691.4 11408.5 11938.1 12051.9 12263.3 39217.0 39257.8 39924.8 39944.4 40508.0 65397.0 70314.3 70906.6 71570.8 71741.0 15994.4 16096.1 16221.3 16405.8 16424.7 16591.5 17615.6 17771.0 17873.8 18007.1 16048.4 16255.9 16516.6 16673.0 16706.3 14073.7 16088.7 16374.9 16405.6 17055.2 16644.8 16669.1 16797.7 16801.2 16810.2 11726.9 11853.6 11895.4 11992.4 12200.5 12660.8 12974.9 12996.5 12999.5 13227.9 16:18:48 INFO - PID 1636 | -------- Summary: end -------- 16:18:48 INFO - PID 1636 | 16:18:48 INFO - TEST-INFO | 1636: exit 0 16:18:48 INFO - TEST-OK | dromaeo_css | took 1119158ms 16:18:48 INFO - TEST-START | kraken 16:18:48 INFO - operating with platform_type : mac_ 16:18:48 INFO - Initialising browser for kraken test... 16:18:49 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp9YAZe9/profile http://localhost:49250/getInfo.html) 16:18:51 INFO - PID 1646 | __metrics Screen width/height:1600/1200 16:18:51 INFO - PID 1646 | colorDepth:24 16:18:51 INFO - PID 1646 | Browser inner width/height: 1024/689 16:18:51 INFO - PID 1646 | __metrics 16:18:51 INFO - PID 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:18:51 INFO - PID 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:18:52 INFO - TEST-INFO | 1646: exit 0 16:18:52 INFO - Browser initialized. 16:18:52 INFO - Running cycle 1/1 for kraken test... 16:18:52 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp9YAZe9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:04 INFO - PID 1647 | RSS: Main: 242544640 16:19:04 INFO - PID 1647 | 16:19:07 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:08 INFO - PID 1647 | RSS: Main: 311934976 16:19:08 INFO - PID 1647 | 16:19:10 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 16:19:11 INFO - PID 1647 | RSS: Main: 294162432 16:19:11 INFO - PID 1647 | 16:19:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 16:19:15 INFO - PID 1647 | RSS: Main: 384671744 16:19:15 INFO - PID 1647 | 16:19:17 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 16:19:18 INFO - PID 1647 | RSS: Main: 287105024 16:19:18 INFO - PID 1647 | 16:19:20 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:20 INFO - PID 1647 | RSS: Main: 289484800 16:19:20 INFO - PID 1647 | 16:19:23 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:24 INFO - PID 1647 | RSS: Main: 355225600 16:19:24 INFO - PID 1647 | 16:19:27 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:27 INFO - PID 1647 | RSS: Main: 376385536 16:19:27 INFO - PID 1647 | 16:19:30 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 16:19:31 INFO - PID 1647 | RSS: Main: 389394432 16:19:31 INFO - PID 1647 | 16:19:32 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:33 INFO - PID 1647 | RSS: Main: 332636160 16:19:33 INFO - PID 1647 | 16:19:35 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:35 INFO - PID 1647 | RSS: Main: 333090816 16:19:35 INFO - PID 1647 | 16:19:38 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:38 INFO - PID 1647 | RSS: Main: 334667776 16:19:38 INFO - PID 1647 | 16:19:41 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:42 INFO - PID 1647 | RSS: Main: 333508608 16:19:42 INFO - PID 1647 | 16:19:45 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:46 INFO - PID 1647 | RSS: Main: 344358912 16:19:46 INFO - PID 1647 | 16:19:47 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 16:19:48 INFO - PID 1647 | RSS: Main: 387690496 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | __start_tp_report 16:19:48 INFO - PID 1647 | _x_x_mozilla_page_load 16:19:48 INFO - PID 1647 | _x_x_mozilla_page_load_details 16:19:48 INFO - PID 1647 | |i|pagename|runs| 16:19:48 INFO - PID 1647 | |0;ai-astar;111;113;112;111;111;112;111;112;112;112 16:19:48 INFO - PID 1647 | |1;audio-beat-detection;142;109;110;150;112;110;110;104;140;118 16:19:48 INFO - PID 1647 | |2;audio-dft;200;262;190;186;184;181;184;186;182;183 16:19:48 INFO - PID 1647 | |3;audio-fft;78;58;59;88;62;56;62;59;84;59 16:19:48 INFO - PID 1647 | |4;audio-oscillator;89;69;86;69;71;69;90;69;71;89 16:19:48 INFO - PID 1647 | |5;imaging-gaussian-blur;95;90;95;94;90;134;105;91;93;90 16:19:48 INFO - PID 1647 | |6;imaging-darkroom;96;96;95;96;95;96;97;96;96;96 16:19:48 INFO - PID 1647 | |7;imaging-desaturate;87;83;86;86;82;82;84;82;84;83 16:19:48 INFO - PID 1647 | |8;json-parse-financial;51;48;48;49;49;50;50;51;53;52 16:19:48 INFO - PID 1647 | |9;json-stringify-tinderbox;53;59;54;61;69;62;58;58;57;57 16:19:48 INFO - PID 1647 | |10;stanford-crypto-aes;84;83;84;83;83;82;82;82;89;87 16:19:48 INFO - PID 1647 | |11;stanford-crypto-ccm;138;141;133;135;136;137;137;136;185;143 16:19:48 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;186;183;186;190;182;183;185;186;178;184 16:19:48 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;67;67;67;68;66;67;66;73;90;90 16:19:48 INFO - PID 1647 | __end_tp_report 16:19:48 INFO - PID 1647 | __start_cc_report 16:19:48 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2218 16:19:48 INFO - PID 1647 | __end_cc_report 16:19:48 INFO - PID 1647 | __startTimestamp1492557588089__endTimestamp 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | ------- Summary: start ------- 16:19:48 INFO - PID 1647 | Number of tests: 14 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 16:19:48 INFO - PID 1647 | Values: 111.0 113.0 112.0 111.0 111.0 112.0 111.0 112.0 112.0 112.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:115.00 stddev:16.75 (14.6%) stddev-sans-first:15.86 16:19:48 INFO - PID 1647 | Values: 142.0 109.0 110.0 150.0 112.0 110.0 110.0 104.0 140.0 118.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:193.80 Median:186.00 stddev:24.58 (13.2%) stddev-sans-first:25.97 16:19:48 INFO - PID 1647 | Values: 200.0 262.0 190.0 186.0 184.0 181.0 184.0 186.0 182.0 183.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.00 stddev:11.98 (19.3%) stddev-sans-first:11.97 16:19:48 INFO - PID 1647 | Values: 78.0 58.0 59.0 88.0 62.0 56.0 62.0 59.0 84.0 59.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.50 stddev:9.81 (12.5%) stddev-sans-first:9.43 16:19:48 INFO - PID 1647 | Values: 89.0 69.0 86.0 69.0 71.0 69.0 90.0 69.0 71.0 89.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:97.70 Median:92.00 stddev:13.52 (14.7%) stddev-sans-first:14.30 16:19:48 INFO - PID 1647 | Values: 95.0 90.0 95.0 94.0 90.0 134.0 105.0 91.0 93.0 90.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:19:48 INFO - PID 1647 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.85 (2.2%) stddev-sans-first:1.59 16:19:48 INFO - PID 1647 | Values: 87.0 83.0 86.0 86.0 82.0 82.0 84.0 82.0 84.0 83.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.50 stddev:1.66 (3.3%) stddev-sans-first:1.73 16:19:48 INFO - PID 1647 | Values: 51.0 48.0 48.0 49.0 49.0 50.0 50.0 51.0 53.0 52.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:4.52 (7.7%) stddev-sans-first:4.28 16:19:48 INFO - PID 1647 | Values: 53.0 59.0 54.0 61.0 69.0 62.0 58.0 58.0 57.0 57.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.33 (2.8%) stddev-sans-first:2.47 16:19:48 INFO - PID 1647 | Values: 84.0 83.0 84.0 83.0 83.0 82.0 82.0 82.0 89.0 87.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:137.50 stddev:15.34 (11.2%) stddev-sans-first:16.20 16:19:48 INFO - PID 1647 | Values: 138.0 141.0 133.0 135.0 136.0 137.0 137.0 136.0 185.0 143.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:185.50 stddev:3.16 (1.7%) stddev-sans-first:3.30 16:19:48 INFO - PID 1647 | Values: 186.0 183.0 186.0 190.0 182.0 183.0 185.0 186.0 178.0 184.0 16:19:48 INFO - PID 1647 | 16:19:48 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:67.50 stddev:9.64 (14.3%) stddev-sans-first:10.05 16:19:48 INFO - PID 1647 | Values: 67.0 67.0 67.0 68.0 66.0 67.0 66.0 73.0 90.0 90.0 16:19:48 INFO - PID 1647 | -------- Summary: end -------- 16:19:48 INFO - PID 1647 | 16:19:49 INFO - TEST-INFO | 1647: exit 0 16:19:49 INFO - TEST-OK | kraken | took 60268ms 16:19:49 INFO - SUITE-END | took 1179s 16:19:49 INFO - Completed test suite (00:19:39) 16:19:49 INFO - javascript benchmark 16:19:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7712.717745024965, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3221.822799746014, 3511.9824400878006, 3537.964620353796, 3548.8403021864015, 3601.585817630973, 5958.7616495340135, 6111.969440152804, 6131.938680613192, 6132.478739307158, 6169.537284703642, 6041.788537401192, 6054.576179667425, 6095.922000763714, 6108.69456527174, 6115.327313995468, 5324.094903866333, 5329.360476742796, 5330.333708286465, 5340.465953404668, 5542.057850165462, 610.8756001406587, 5446.863828404302, 5448.210009548613, 5458.5087342139195, 5459.563234941215, 4715.221988371914, 5272.288241087443, 5296.311479507659, 5357.196420536911, 5360.865978350573, 5342.492463215988, 5346.893062138774, 5347.54545863602, 5355.062863998784, 5379.865503362408, 5186.325777648882, 5348.572114230852, 5350.678959262418, 5361.758720857571, 5380.838574842761, 6073.119397687355, 6077.617041570647, 6093.360197179277, 6128.111423843562, 6166.784162554289, 6571.93428065718, 6579.342065793382, 6586.0, 6592.637404942726, 6596.637184954826, 6627.73489060437, 6659.766908158192, 6668.766593169215, 6681.131452911139, 6682.632455214961, 6033.818985430444, 6156.107364432221, 6163.599366041193, 6170.074488826712, 6224.813255602339, 6570.047343135314, 6585.111010013683, 6587.934120658732, 6592.967035164889, 6711.060451536789, 6411.326810684905, 6478.0, 6485.6108633482145, 6491.67541622917, 6498.025296205513, 6342.904856427157, 6347.5556711029785, 6400.135981642512, 6422.100905873182, 6431.74273029083, 6552.0, 6564.146660934048, 6576.44100251484, 6585.275619681831, 6589.868202636017, 6287.685615719287, 6611.438027767597, 6614.503912206604, 6619.569727967763, 6630.701618427182, 5217.530422261939, 5223.425423203445, 5272.9736351318, 5295.4439783822145, 5367.973160134175, 4689.882752931136, 4696.201645720235, 4700.529947005272, 4702.4592171899985, 4776.188048031843, 6213.502919766408, 6219.440250377397, 6235.906461403082, 6245.5628106032145, 6248.875022499525, 6312.495000399957, 6452.4515416189215, 6452.774152904626, 6674.432673222734, 6676.399124078856, 6153.892299386153, 6172.197614310111, 6248.4688801452385, 6251.093591429218, 6264.498840092781, 5819.330776960704, 5832.62087964281, 5835.503982161564, 5869.266341707286, 5873.970630146822, 5759.85600359986, 6760.898586521304, 6769.729210831511, 6773.322667733188, 6823.249442561413, 6370.93629063722, 6453.064305675557, 6454.67726613658, 6457.903131453126, 6458.38645328693, 6599.340065993362, 6610.768623098168, 6718.093057437183, 6810.965945170243, 6843.8973415399805, 6520.510961677988, 6533.379328963741, 6550.901736473861, 6568.211814582281, 6588.934110658832, 6657.900131498128, 6660.533762636569, 6670.166229221348, 6677.399034086761, 6680.064790929371, 5857.150713146655, 6297.275813281348, 6363.872722545616, 6450.0, 6474.708638111202, 6378.362163783585, 6417.96791016042, 6459.450946669585, 6463.676816159267, 6464.773732919325, 6316.905246421215, 6318.0, 6328.651924144032, 6341.49268058545, 6349.68251587428, 6205.720742566686, 6397.456216221487, 6461.06314584392, 6464.903026454513, 6504.902426463702, 6215.378462153749, 6221.96889015552, 6283.622982621057, 6303.905441418291, 6309.053641953744], "value": 5977.11331232086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.4777084384664, 777.7627823513828, 797.0594698256058, 1120.4341807387268, 1141.5376772407178, 27841.16476505703, 28142.718572814265, 37671.4349284761, 37904.62095379045, 38139.23721525568, 40269.194616107736, 40674.0, 40684.389734154014, 40688.0, 40713.0, 7865.567393793353, 8019.35845132388, 8028.5182889026555, 8030.156833532454, 8044.798880028017, 5661.0, 5773.220615216934, 5791.739371728261, 5791.7972870949525, 7893.131755506918, 5816.82549523515, 5856.267966504187, 7759.41804364672, 7941.364690824749, 7961.482503637245, 7909.841803163933, 7962.163972782832, 7978.481398709066, 7979.0, 7985.081715602664, 7726.690932362699, 7816.765497035098, 7818.179091195399, 7835.804104897366, 7841.255080767318, 37754.43368349477, 37905.24189516194, 37974.0, 37986.810065949496, 38057.0485737856, 3545.7517973741847, 3584.229390681016, 3593.5148754918014, 3594.4069228577255, 3600.873969411058, 31028.0, 31052.223694407596, 31194.908178213653, 31241.188293053736, 31263.0, 2718.768904643108, 3143.1513491357205, 3200.7439404847555, 3206.0, 3219.4044101841, 213461.0, 271264.0, 271375.0, 272603.0, 273624.0, 45842.0, 47176.52823471721, 50489.242661360106, 50577.74711126421, 50697.74651126721, 53407.0, 53408.73295633497, 53456.0, 53633.92732145335, 53686.46313536815, 14004.929975350058, 14085.507007254902, 14094.647633809236, 14103.153810771386, 14192.361343739556, 11326.980571748418, 11347.943260283811, 11367.147463940237, 11368.488418021208, 11369.943150284362, 11143.0, 12897.0, 13234.07361484706, 13270.0, 13341.19952802835, 4702.56571745614, 4788.569028787426, 4798.8884890648005, 4813.205821039559, 4818.759062046884, 802.7511471443871, 933.673214374977, 963.4026903319987, 1004.3729158762851, 1017.6896046705677, 22955.0, 23744.762552374254, 23764.0, 23789.524209515712, 23797.0, 1112.7663190730038, 1113.493360520961, 1149.494222542079, 1151.4703236511132, 1153.5962413155328, 11661.88338116625, 12301.753964920652, 12315.076369272341, 12360.629181124581, 12698.0, 252962.0, 253946.0, 254438.0, 254754.72622636767, 255646.0, 50786.746066269436, 50861.74569127131, 50945.49054509407, 51020.0, 51028.489715102376, 1483.480781726387, 1488.2856229010135, 1529.06726896593, 1533.9309731062128, 1548.3187397545043, 20981.265655701976, 22257.332280031624, 23129.653055204522, 23212.86626305427, 23315.300540983797, 36787.0, 36840.44739328859, 36862.44706329461, 36910.8154459226, 37012.0, 236453.0, 237837.0, 237879.0, 238096.0, 238141.23717525898, 33672.83163584166, 33785.32429351448, 33793.83103084469, 33852.49221261634, 33881.49177762385, 41669.58330416657, 41971.75353080865, 42436.1512769749, 42439.7878010608, 42486.36270455884, 30470.390592188476, 31051.0, 31943.041708748773, 32035.0, 32252.516212257306, 31067.533986990664, 31819.681803181673, 32208.355832882742, 32284.0, 32334.676653233168, 36614.0, 37428.0, 37972.24055518819, 38194.42708359321, 38202.0, 25933.0, 31589.684103158674, 32162.83918580392, 32518.34963300768, 32666.673333267314, 24185.87907060524, 24246.393840154138, 24306.149284774947, 24656.630150548113, 24677.01291948302], "value": 16762.075935323257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8958081318046, 421.69606932838127, 433.7570960262252, 439.3738922036099, 452.9864104076877, 17363.565910852234, 21202.89398553007, 21994.45013874654, 22900.65649015264, 23000.65499017512, 21976.34070977873, 22547.77452225477, 22856.428589285275, 23130.30609081726, 23594.0, 4800.8319708810195, 4876.268559716035, 5285.524302812746, 5447.918281225785, 5504.889902201953, 4689.507601701824, 5416.837494875141, 5487.478689524489, 5509.9806535791, 5515.365732940703, 5226.2944502492055, 5397.730113494329, 5481.068218402861, 5482.5613950884035, 5485.506304432601, 5302.92045619316, 5314.5216930476445, 5350.732463376835, 5356.276902618136, 5358.892822143535, 4757.785899634525, 4844.128056949748, 4847.418309802811, 4894.1679914414635, 4959.975200124012, 27383.726162738516, 27945.441091178265, 28064.438711225663, 28086.995206366086, 28367.57448638272, 2220.5225876436643, 2292.025888997186, 2292.2206449807145, 2296.552172326397, 2298.333483289844, 17924.731129033076, 17932.820671793244, 17987.73018404712, 18543.629127417513, 18739.0, 2107.620628286908, 2113.0913707105938, 2161.103142195987, 2164.7835216478384, 2165.8700477971215, 128078.3596082023, 136780.58048548768, 140149.0, 146032.0, 147506.0, 11737.0, 11952.521899123938, 12517.874821251671, 12559.0, 12980.740385192243, 15563.377464901503, 16582.83417165837, 16710.415135470445, 16944.661106777796, 16983.74524382135, 8775.254103401156, 8786.516741579275, 8916.55417229149, 9024.639014439348, 9098.909010909938, 7616.35261002821, 7937.920620793833, 8396.118407567239, 8403.537805420638, 8595.312375009984, 7886.645100970355, 8031.638576264082, 8033.437659363905, 8042.879356809653, 8062.959685201537, 2009.4474019644715, 2023.4738967868166, 2039.6124736300055, 2167.5556510915226, 2189.2994241842775, 935.4480856294819, 964.6205925526565, 967.8385936875777, 988.4168340679034, 998.5456617239139, 16312.51062468128, 16608.418705345255, 20349.593008139753, 21011.78988210129, 21366.679499807517, 971.2133172130597, 977.1596427072711, 991.7124034030195, 1002.4486532407146, 1010.3634710132569, 9053.230475409664, 10860.67417977462, 10907.509162087566, 10971.780564388668, 10972.286801357886, 458018.0, 463647.0, 512945.0, 535475.3226233844, 550706.0, 131132.0, 136246.95629565563, 138095.0, 141374.0, 146450.0, 1175.9412029398495, 1195.9893889663394, 1222.9449674764658, 1226.7423840993313, 1231.6551365617463, 21578.892105539373, 22363.88818055899, 22654.0, 22685.8865705677, 22869.19957801469, 58642.82714345604, 59984.700076499335, 60467.0, 60539.69730151321, 61063.0, 65149.83407052082, 79961.0, 80728.32518907038, 84718.15281847103, 85534.57232713797, 8764.868526971974, 8889.377743557889, 9092.909070909207, 9100.544972751204, 9292.814143717223, 11035.944820275847, 14197.793187579171, 14536.345864435914, 14586.4894728684, 14680.339384727926, 11844.0, 11850.525978960744, 11966.700832479257, 12055.51777928873, 12122.75754484923, 9913.702588922344, 10715.732106697084, 11312.377819220023, 11397.259178153394, 11660.358680272666, 11971.401429928643, 11989.160758746804, 12109.455074521491, 12170.45232964501, 12188.939055304667, 7349.228331025379, 7430.888536671846, 8932.28541716674, 9021.278297736297, 9048.140426659456, 11817.586384476503, 11864.584739534075, 12006.579769708018, 12008.939955300517, 12025.398730063287], "value": 10250.85308481143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.5831250624813, 1451.8838492920568, 1478.7042591481702, 1480.896337256392, 1490.500682271439, 11592.710182245448, 12039.458224379901, 12045.698857528545, 12066.81899771503, 12075.033997280218, 11382.260153090065, 11567.248128871617, 11604.709882252926, 11778.11664125192, 11785.23395979263, 2488.4774197418565, 2530.1903390914913, 2538.4669219463844, 2538.6953565572157, 2541.2122242104915, 2450.9142180023705, 2458.2423567149485, 2495.36368226103, 2497.1509686706518, 2497.5254701606727, 2444.278937713379, 2523.8611876346795, 2532.962005569918, 2538.111660918682, 2541.504406640706, 2466.962995555068, 2486.4032632168332, 2498.750124987505, 2524.596064629669, 2531.4430825218424, 2490.2404766546197, 2495.8502489850666, 2518.7229404765462, 2530.266222795387, 2531.5949448088218, 11475.311481311148, 11625.418729063598, 11706.414679266003, 11713.004394626467, 11761.529538818437, 4784.306275590055, 6393.328700486475, 6394.712237949303, 6412.67936603168, 6412.871742565169, 4011.0, 4256.276433006366, 4300.118475712471, 4306.332518459643, 4358.825646974117, 1231.9753604927942, 1233.6792433967144, 1315.421214665544, 1315.9539416120485, 1318.3671837518045, 14934.0, 15363.385464581403, 15367.231638418147, 16062.116583587898, 16469.258883350278, 4656.650751193606, 5411.2153737708595, 5423.918641220384, 5429.728513574306, 5930.673812940329, 13891.235982021086, 13893.166410015432, 13925.582232533041, 13930.512432064828, 13948.72102557943, 6558.901616475757, 6751.932480675228, 6757.425618822455, 6781.694823732944, 6788.0, 5930.673812940329, 6103.450689437883, 6126.111713801563, 6262.968685156545, 6268.686565671698, 3829.6936245100883, 4566.949601591586, 4699.17764391237, 4720.433547974265, 4761.6904901181315, 1264.873512648746, 1438.992805035968, 1442.278860569715, 1464.3483649775746, 1469.6619777451033, 704.3871831506519, 787.9724209652635, 800.7237503061434, 817.0603805623581, 821.8643923752634, 6613.4709223262025, 6849.315068493111, 6968.965155174192, 6978.337057979484, 7065.364117229474, 748.292863244229, 943.5235206220951, 952.0717300631967, 953.4374718915734, 953.6757502449201, 3808.7143464240294, 3828.904277393032, 3869.690424766012, 3904.4533765272886, 3952.723309368374, 14580.125192488485, 15228.0, 15228.543143705707, 15239.161846098572, 15243.618909527351, 15095.32071056783, 15109.622259443602, 15136.394544218108, 15149.621259468602, 15152.393904243707, 8222.917770822334, 8594.140585941355, 8784.253338466175, 8797.780055498535, 8807.251383632334, 6535.509836762167, 6595.934040659532, 6714.764983225564, 6722.529422940347, 6765.221999470124, 12976.351182441029, 13635.79546306826, 13641.795373069213, 13652.795208072086, 13659.521916732867, 11635.592754253561, 12347.567835125728, 12871.420786064462, 13785.793213101611, 14084.22536760488, 9471.052894710749, 9737.318387712792, 9742.9025709742, 9753.02469753019, 9762.36544624597, 10569.0, 10654.14766818668, 10726.678199654023, 10773.62292319765, 10784.406857622906, 8830.205281524693, 8948.002419189645, 9011.23404510624, 9089.681861134828, 9180.403273787182, 6830.863382732218, 8656.177663121993, 8817.294616430541, 8842.292616590528, 8911.15344042315, 8071.919280807117, 8185.181481851767, 8203.015638123463, 8211.671533138846, 8247.670093196204, 5908.877313310629, 5921.61509501881, 6045.697715114315, 6119.724612392364, 6190.659513726608, 5875.0, 6018.024131977421, 6065.696715164312, 6192.164057852313, 6250.843728906631], "value": 5410.980204533367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.9298126337258, 391.6338223760784, 392.81930312056454, 395.1523981060625, 403.5339183243354, 5873.647581145129, 5875.794347197843, 5907.704614769265, 5914.2902851657755, 5952.55355848311, 5531.419200983899, 5710.514606258463, 5734.369219385874, 5787.594868359217, 5861.7362218700155, 3907.492026036611, 4436.6672499562665, 4471.910561788763, 4477.283634618461, 4479.3952816369865, 4085.9795701021453, 4140.143301122216, 4286.97856510717, 4463.196624607569, 4475.664325175609, 3513.5608048993877, 3629.5100161478126, 3860.6332398422105, 4419.62433193179, 4473.194824931511, 3808.5239345081864, 3983.50206224222, 4296.591823776736, 4444.200043992097, 4476.776161191944, 3697.8705745299053, 3741.7193710471824, 3936.5866584008554, 3971.7616942983514, 3987.9202415951518, 4670.299455081731, 5203.193505006692, 5748.482636562688, 5778.093229234342, 5823.097419899922, 4363.498197707241, 5265.894682106375, 5324.361076670785, 5326.201069839516, 5329.706866122362, 5145.974270128663, 5442.782288708447, 6240.441419018181, 6275.341089185616, 6315.0, 3739.6821270192067, 3755.1134575714277, 4359.80380882861, 4481.439820022497, 4546.749928753918, 4912.926306105412, 5370.516653501165, 5712.0, 6044.546659000593, 6541.21505419348, 4198.832046718097, 4683.836065737751, 4694.389729335165, 4711.293306004127, 4711.327478744996, 4776.8566942991765, 4779.378680771478, 4798.928016079762, 4799.256579867709, 4808.807647694053, 4210.957890421118, 4921.0, 4939.975300123477, 5088.0, 5413.539849112791, 4731.006488637356, 6177.4749146322165, 6290.930541807904, 6342.651154186564, 6355.396237357444, 1595.5293188509418, 1612.4759453177764, 1635.803703555581, 1636.1982628511944, 1644.2436479219455, 1113.4043286841502, 1120.9775804483866, 1123.7977164110375, 1133.3596517967321, 1139.487230746151, 5872.383399743051, 5891.41085891416, 5895.700676736076, 5899.616524925866, 5903.675297858573, 5936.821895343147, 6144.293406258248, 6478.352164783578, 6492.09110724499, 6500.6424646643945, 5270.736463176826, 5682.289713785777, 5753.424657534213, 5849.385814489502, 5861.560382971209, 2683.3828219509624, 2957.4085182963063, 3122.6408962969094, 3359.764816462873, 3393.8121657419706, 5096.833845615599, 5258.790478190038, 6560.770373036921, 6590.637514936629, 6615.6030638161865, 6616.569922954993, 6628.966855165693, 6629.303923088103, 6632.403083722488, 6656.068150458939, 6383.872322553616, 6549.279579246279, 6589.275179730322, 6635.535512514174, 6644.302348253364, 5196.68819870809, 5437.510624043855, 5723.141528770718, 6169.938300616936, 6453.354664533509, 4821.46963833985, 5456.306607683147, 5723.227364305932, 6057.0, 6406.23125224976, 6077.0, 6500.902486462613, 6594.934050659624, 6616.172978377703, 6618.437432818265, 4165.229432554987, 4416.984093658541, 4663.743494107856, 4679.812807487662, 4683.578477937002, 5783.19035335045, 6156.78451254204, 6436.742530298736, 6478.3197764235965, 6478.611283323015, 5288.68267903927, 5462.890742185214, 5698.287714035746, 6151.9384806151365, 6231.813045608639, 6038.1922406081385, 6230.376962303914, 6247.5939063960695, 6247.9694099416965, 6258.906116408349, 5609.411011843697, 6057.1519987200945, 6106.3588323227195, 6152.907706384318, 6162.661053642093, 6222.7952604409675, 6244.750209991549, 6268.435840774352, 6282.748690052346, 6297.960836462115, 5785.566082543742, 6000.0999850022845, 6044.609739759792, 6061.39386061408, 6073.696315184135], "value": 4582.779729352207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.7379732600275, 757.257887270475, 819.176727388974, 839.7529668442364, 855.9186877246659, 13541.729165416686, 18057.72913406298, 18185.454236389924, 18734.250629974784, 18811.34160304388, 14156.71686566268, 17155.742663860052, 17671.028093454854, 17735.290588376483, 17747.645047099082, 961.1637875048717, 988.6391467114487, 994.2990191914682, 995.343073571443, 996.1482932093065, 628.1927722876105, 667.5614051718554, 693.4313862632644, 699.0911814640972, 1018.1752780247986, 941.6233506597347, 1002.5889385352007, 1047.5809676129534, 1050.9316894401877, 1052.0426411965113, 1039.8960103989616, 1041.0630432610635, 1041.406398352939, 1042.4214560918688, 1046.053321743823, 770.630097553172, 771.8417724366492, 773.1842905734447, 773.8839174123871, 775.8293175501437, 16441.342346306134, 16446.424375146933, 16728.58178545534, 17111.31554737809, 17410.30358785647, 13863.376148073361, 16643.91678041602, 16742.58143546409, 17200.397986070428, 17282.740758888627, 13897.583072507841, 14081.85918140826, 14142.0, 14221.075630084011, 14336.996410251286, 3349.346877358916, 3373.730101591867, 3374.3420033093557, 3374.645662205482, 3380.509826075205, 115307.0, 117531.0, 117746.0, 117803.0, 118847.0, 10883.0, 11048.67415910096, 11976.88023119775, 12321.383930803424, 12339.62981110568, 18377.632447350978, 20029.49926251826, 25192.496150076895, 25258.621120682837, 25394.0, 7600.961995189989, 7741.380689544823, 7745.92254077452, 7759.2240775921955, 7773.028371453568, 3945.033466800652, 4007.6793856491995, 4038.172174704179, 4039.2527382434346, 4044.0092177416723, 4344.847930322487, 4422.513523512475, 4484.865454036384, 4488.932666010012, 4489.147062058199, 806.1776987472745, 874.1127755328347, 908.5094049213483, 919.2783664823082, 919.8850143732034, 636.9076483909807, 643.3823529411724, 643.9034144878306, 646.7348387161242, 679.2765704524666, 10834.187435942336, 11036.240939765059, 11643.53425862973, 11888.762224755457, 12210.328431936328, 650.6746626686656, 665.2250128600224, 667.9398854103154, 676.0805304785488, 683.6513378177166, 5390.275111964213, 5543.223948647193, 5962.211336599003, 6073.0, 6260.311365749764, 102404.0, 104178.0, 105992.0, 106833.46583267034, 107962.0, 91971.0, 92296.0, 94025.0, 94485.5275723617, 95121.0, 80923.97690057677, 81233.18766812375, 81264.0, 82146.17853821504, 83161.0, 9691.418514889128, 11408.486618102039, 11938.1046421517, 12051.879481205076, 12263.26420414778, 39217.0, 39257.803710981265, 39924.80037599793, 39944.40083398693, 40508.0, 65397.0, 70314.29685703282, 70906.64546677233, 71570.769361522, 71741.0, 15994.440194593133, 16096.11471369086, 16221.270042847864, 16405.753913691064, 16424.67150657004, 16591.502254932373, 17615.647687046443, 17771.0, 17873.821261787736, 18007.09964501796, 16048.438304659281, 16255.918720406322, 16516.587085322964, 16673.0, 16706.33174673048, 14073.718525629634, 16088.678226435171, 16374.918125409296, 16405.58986025359, 17055.232514536627, 16644.833551664327, 16669.083200424095, 16797.66404671924, 16801.159942003094, 16810.243539041017, 11726.88273117258, 11853.644390668294, 11895.405229738652, 11992.400379980792, 12200.450979706113, 12660.810087848873, 12974.873167418917, 12996.480140794263, 12999.480020799063, 13227.867721322664], "value": 8264.75051009829, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1438.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 150.0, 112.0, 110.0, 110.0, 104.0, 140.0, 118.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 262.0, 190.0, 186.0, 184.0, 181.0, 184.0, 186.0, 182.0, 183.0], "value": 193.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 88.0, 62.0, 56.0, 62.0, 59.0, 84.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 86.0, 69.0, 71.0, 69.0, 90.0, 69.0, 71.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 90.0, 95.0, 94.0, 90.0, 134.0, 105.0, 91.0, 93.0, 90.0], "value": 97.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 86.0, 82.0, 82.0, 84.0, 82.0, 84.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 48.0, 48.0, 49.0, 49.0, 50.0, 50.0, 51.0, 53.0, 52.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 54.0, 61.0, 69.0, 62.0, 58.0, 58.0, 57.0, 57.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 83.0, 83.0, 82.0, 82.0, 82.0, 89.0, 87.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 133.0, 135.0, 136.0, 137.0, 137.0, 136.0, 185.0, 143.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 186.0, 190.0, 182.0, 183.0, 185.0, 186.0, 178.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 66.0, 67.0, 66.0, 73.0, 90.0, 90.0], "value": 72.1, "unit": "score"}]}]} 16:19:49 INFO - Return code: 0 16:19:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:19:49 ERROR - # TBPL SUCCESS # 16:19:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:49 INFO - 2017-04-18 16:19:49.901 screenresolution[1652:9756] starting screenresolution argv=screenresolution get 16:19:49 INFO - 2017-04-18 16:19:49.904 screenresolution[1652:9756] Display 0: 1600x1200x32@60 16:19:49 INFO - 2017-04-18 16:19:49.910 screenresolution[1653:9759] starting screenresolution argv=screenresolution list 16:19:49 INFO - Available Modes on Display 0 16:19:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:50 INFO - Intel Iris: 16:19:50 INFO - Chipset Model: Intel Iris 16:19:50 INFO - Type: GPU 16:19:50 INFO - Bus: Built-In 16:19:50 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:50 INFO - Vendor: Intel (0x8086) 16:19:50 INFO - Device ID: 0x0a2e 16:19:50 INFO - Revision ID: 0x0009 16:19:50 INFO - Displays: 16:19:50 INFO - Display: 16:19:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:50 INFO - Display Serial Number: 1600x1200 60 16:19:50 INFO - Main Display: Yes 16:19:50 INFO - Mirror: Off 16:19:50 INFO - Online: Yes 16:19:50 INFO - Rotation: Supported 16:19:50 INFO - Return code: 0 16:19:50 INFO - Running post-action listener: _resource_record_post_action 16:19:50 INFO - [mozharness: 2017-04-18 23:19:50.145067Z] Finished run-tests step (success) 16:19:50 INFO - Running post-run listener: _resource_record_post_run 16:19:50 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 39327232; Write bytes: 514298880; Read time: 392; Write time: 1613 16:19:50 INFO - TinderboxPrint: CPU usage
53.4% 16:19:50 INFO - TinderboxPrint: I/O read bytes / time
39,327,232 / 392 16:19:50 INFO - TinderboxPrint: I/O write bytes / time
514,298,880 / 1,613 16:19:50 INFO - TinderboxPrint: CPU idle
2,238.4 (46.6%) 16:19:50 INFO - TinderboxPrint: CPU system
960.7 (20.0%) 16:19:50 INFO - TinderboxPrint: CPU user
1,606.6 (33.4%) 16:19:50 INFO - TinderboxPrint: Swap in / out
247,107,584 / 0 16:19:50 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204093952; Write bytes: 205075968; Read time: 16478; Write time: 406 16:19:50 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 37443072; Write bytes: 302448128; Read time: 366; Write time: 1180 16:19:50 INFO - Running post-run listener: _upload_blobber_files 16:19:50 INFO - Blob upload gear active. 16:19:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:50 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 16:19:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:19:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:52 INFO - (blobuploader) - INFO - Done attempting. 16:19:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:19:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:53 INFO - (blobuploader) - INFO - Done attempting. 16:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:54 INFO - (blobuploader) - INFO - Done attempting. 16:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:56 INFO - (blobuploader) - INFO - Done attempting. 16:19:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:56 INFO - Return code: 0 16:19:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e8af6b4ca855cecfe76a3c146c2f55d68c39187ec3adead82fc00aa52ca606fe072cdb38d471056d5c0171ef4eaf410eaf784da73e0fd7f7dba795f25ccc19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f6447df98ad014f1c935f6bcc992bf6bd1f8cc0fea8e866a4ea0c0d81dc767e72172e392cfa319b09ff2efadad9473927b21d205fe25706868e6087f8bc34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e1b1e05a6da13bcaa1ba7f31ad8c83a4af6a1740ee2765a6a06e978334c910bccb3cb202c0feca4288534569bbe80227aef9f94abb1ca20cea1aecce230388e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75fb8ef41d2d67e5c123ef172d811137c88ee7a301854e082a45597bee342945b022e27374f06de2fe9e99111e4d02b9bc9e7b8c6e3c171ed1390e9ccecefe6"} 16:19:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:56 INFO - Contents: 16:19:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e8af6b4ca855cecfe76a3c146c2f55d68c39187ec3adead82fc00aa52ca606fe072cdb38d471056d5c0171ef4eaf410eaf784da73e0fd7f7dba795f25ccc19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f6447df98ad014f1c935f6bcc992bf6bd1f8cc0fea8e866a4ea0c0d81dc767e72172e392cfa319b09ff2efadad9473927b21d205fe25706868e6087f8bc34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e1b1e05a6da13bcaa1ba7f31ad8c83a4af6a1740ee2765a6a06e978334c910bccb3cb202c0feca4288534569bbe80227aef9f94abb1ca20cea1aecce230388e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75fb8ef41d2d67e5c123ef172d811137c88ee7a301854e082a45597bee342945b022e27374f06de2fe9e99111e4d02b9bc9e7b8c6e3c171ed1390e9ccecefe6"} 16:19:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:56 INFO - Copying logs to upload dir... 16:19:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.945134 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-18 16:19:56.732096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:56.735742) ========= 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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e8af6b4ca855cecfe76a3c146c2f55d68c39187ec3adead82fc00aa52ca606fe072cdb38d471056d5c0171ef4eaf410eaf784da73e0fd7f7dba795f25ccc19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f6447df98ad014f1c935f6bcc992bf6bd1f8cc0fea8e866a4ea0c0d81dc767e72172e392cfa319b09ff2efadad9473927b21d205fe25706868e6087f8bc34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e1b1e05a6da13bcaa1ba7f31ad8c83a4af6a1740ee2765a6a06e978334c910bccb3cb202c0feca4288534569bbe80227aef9f94abb1ca20cea1aecce230388e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75fb8ef41d2d67e5c123ef172d811137c88ee7a301854e082a45597bee342945b022e27374f06de2fe9e99111e4d02b9bc9e7b8c6e3c171ed1390e9ccecefe6"} build_url:https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/So_FxNfLSDOvmQCQgB-RYQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44e8af6b4ca855cecfe76a3c146c2f55d68c39187ec3adead82fc00aa52ca606fe072cdb38d471056d5c0171ef4eaf410eaf784da73e0fd7f7dba795f25ccc19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4f6447df98ad014f1c935f6bcc992bf6bd1f8cc0fea8e866a4ea0c0d81dc767e72172e392cfa319b09ff2efadad9473927b21d205fe25706868e6087f8bc34f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e1b1e05a6da13bcaa1ba7f31ad8c83a4af6a1740ee2765a6a06e978334c910bccb3cb202c0feca4288534569bbe80227aef9f94abb1ca20cea1aecce230388e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d75fb8ef41d2d67e5c123ef172d811137c88ee7a301854e082a45597bee342945b022e27374f06de2fe9e99111e4d02b9bc9e7b8c6e3c171ed1390e9ccecefe6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:56.773616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:56.773948) ========= 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.HWQcqDpPsT/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.3JEFIhKTSQ/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005284 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 16:19:56.823225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 16:19:56.823536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 16:19:56.823903) ========= ========= Total master_lag: 0.18 =========