builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0236 starttime: 1484843334.17 results: success (0) buildid: 20170119071129 builduid: c70f3fdf1f924acab3275675a44e0caf revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.168585) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.169014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.169295) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.203642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.203967) ========= 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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 08:28:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 171M=0s 2017-01-19 08:28:54 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185446 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.528092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.528406) ========= 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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.026090 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:54.574049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-19 08:28:54.574436) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3978751f45108ff1ae002ecebdc0fa23fc52b84 --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 a3978751f45108ff1ae002ecebdc0fa23fc52b84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qgAx2fe5J7/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.ibgrSvBX1E/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 08:28:54,662 truncating revision to first 12 chars 2017-01-19 08:28:54,662 Setting DEBUG logging. 2017-01-19 08:28:54,662 attempt 1/10 2017-01-19 08:28:54,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3978751f451?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 08:28:56,469 unpacking tar archive at: mozilla-central-a3978751f451/testing/mozharness/ program finished with exit code 0 elapsedTime=2.075568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-19 08:28:56.672867) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:56.673171) ========= script_repo_revision: a3978751f45108ff1ae002ecebdc0fa23fc52b84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:56.673591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:56.673873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 08:28:56.694141) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-19 08:28:56.694876) ========= /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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:28:56 INFO - MultiFileLogger online at 20170119 08:28:56 in /builds/slave/test 08:28:56 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 08:28:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:56 INFO - {'append_to_log': False, 08:28:56 INFO - 'base_work_dir': '/builds/slave/test', 08:28:56 INFO - 'blob_upload_branch': 'Firefox', 08:28:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:56 INFO - 'branch': 'Firefox', 08:28:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:56 INFO - 'config_files': ('talos/mac_config.py',), 08:28:56 INFO - 'default_actions': ('clobber', 08:28:56 INFO - 'read-buildbot-config', 08:28:56 INFO - 'download-and-extract', 08:28:56 INFO - 'populate-webroot', 08:28:56 INFO - 'create-virtualenv', 08:28:56 INFO - 'install', 08:28:56 INFO - 'run-tests'), 08:28:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:56 INFO - 'download_minidump_stackwalk': True, 08:28:56 INFO - 'download_symbols': 'ondemand', 08:28:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:56 INFO - 'installer_path': 'installer.exe', 08:28:56 INFO - 'log_level': 'info', 08:28:56 INFO - 'log_name': 'talos', 08:28:56 INFO - 'log_to_console': True, 08:28:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:28:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:28:56 INFO - 'opt_config_files': (), 08:28:56 INFO - 'pip_index': False, 08:28:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:28:56 INFO - 'cmd': ('bash', 08:28:56 INFO - '-c', 08:28:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:28:56 INFO - 'enabled': True, 08:28:56 INFO - 'halt_on_failure': False, 08:28:56 INFO - 'name': 'check_screen_resolution'},), 08:28:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:28:56 INFO - 'cmd': ('bash', 08:28:56 INFO - '-c', 08:28:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:28:56 INFO - 'enabled': True, 08:28:56 INFO - 'halt_on_failure': False, 08:28:56 INFO - 'name': 'check_screen_resolution'},), 08:28:56 INFO - 'run_cmd_checks_enabled': True, 08:28:56 INFO - 'sps_profile': False, 08:28:56 INFO - 'sps_profile_interval': 0, 08:28:56 INFO - 'suite': 'dromaeojs', 08:28:56 INFO - 'system_bits': '32', 08:28:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:56 INFO - 'title': 't-yosemite-r7-0236', 08:28:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:56 INFO - 'use_talos_json': True, 08:28:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:56 INFO - 'work_dir': 'build'} 08:28:56 INFO - [mozharness: 2017-01-19 16:28:56.899858Z] Running clobber step. 08:28:56 INFO - Running pre-action listener: _resource_record_pre_action 08:28:56 INFO - Running main action method: clobber 08:28:56 INFO - rmtree: /builds/slave/test/build 08:28:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:58 INFO - Running post-action listener: _resource_record_post_action 08:28:58 INFO - [mozharness: 2017-01-19 16:28:58.258518Z] Finished clobber step (success) 08:28:58 INFO - [mozharness: 2017-01-19 16:28:58.258684Z] Running read-buildbot-config step. 08:28:58 INFO - Running pre-action listener: _resource_record_pre_action 08:28:58 INFO - Running main action method: read_buildbot_config 08:28:58 INFO - Using buildbot properties: 08:28:58 INFO - { 08:28:58 INFO - "project": "", 08:28:58 INFO - "product": "firefox", 08:28:58 INFO - "script_repo_revision": "production", 08:28:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:28:58 INFO - "repository": "", 08:28:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:28:58 INFO - "buildid": "20170119071129", 08:28:58 INFO - "pgo_build": "False", 08:28:58 INFO - "basedir": "/builds/slave/test", 08:28:58 INFO - "buildnumber": 63, 08:28:58 INFO - "slavename": "t-yosemite-r7-0236", 08:28:58 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:28:58 INFO - "platform": "yosemite_r7", 08:28:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:28:58 INFO - "branch": "mozilla-central", 08:28:58 INFO - "repo_path": "mozilla-central", 08:28:58 INFO - "revision": "a3978751f45108ff1ae002ecebdc0fa23fc52b84", 08:28:58 INFO - "stage_platform": "macosx64", 08:28:58 INFO - "builduid": "c70f3fdf1f924acab3275675a44e0caf", 08:28:58 INFO - "slavebuilddir": "test" 08:28:58 INFO - } 08:28:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:28:58 INFO - Running post-action listener: _resource_record_post_action 08:28:58 INFO - [mozharness: 2017-01-19 16:28:58.262716Z] Finished read-buildbot-config step (success) 08:28:58 INFO - [mozharness: 2017-01-19 16:28:58.262848Z] Running download-and-extract step. 08:28:58 INFO - Running pre-action listener: _resource_record_pre_action 08:28:58 INFO - Running main action method: download_and_extract 08:28:58 INFO - mkdir: /builds/slave/test/build/tests 08:28:58 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')]} 08:28:58 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:28:58 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:28:59 INFO - Downloaded 1199 bytes. 08:28:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:28:59 INFO - Using the following test package requirements: 08:28:59 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:28:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:28:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:28:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'jsshell-mac.zip'], 08:28:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:28:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:28:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:28:59 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:28:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:28:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:28:59 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:28:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:28:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:28:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:28:59 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:29:01 INFO - Expected file size: 16340629 08:29:01 INFO - Obtained file size: 16340629 08:29:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:29:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:29:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:29:07 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:29:08 INFO - Expected file size: 16340629 08:29:08 INFO - Obtained file size: 16340629 08:29:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:29:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:29:14 INFO - Fetch https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:29:16 INFO - Expected file size: 14403463 08:29:16 INFO - Obtained file size: 14403463 08:29:17 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')]} 08:29:17 INFO - trying https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:29:17 INFO - Downloading https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:29:19 INFO - Downloaded 69915509 bytes. 08:29:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:29:19 INFO - mkdir: /builds/slave/test/properties 08:29:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:29:19 INFO - Writing to file /builds/slave/test/properties/build_url 08:29:19 INFO - Contents: 08:29:19 INFO - build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:29:19 INFO - Running post-action listener: _resource_record_post_action 08:29:19 INFO - Running post-action listener: set_extra_try_arguments 08:29:19 INFO - [mozharness: 2017-01-19 16:29:19.957864Z] Finished download-and-extract step (success) 08:29:19 INFO - [mozharness: 2017-01-19 16:29:19.958020Z] Running populate-webroot step. 08:29:19 INFO - Running pre-action listener: _resource_record_pre_action 08:29:19 INFO - Running main action method: populate_webroot 08:29:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:29:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:29:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:29:19 INFO - '--tppagecycles', 08:29:19 INFO - '7'], 08:29:19 INFO - 'tests': ['tsvgm']}}, 08:29:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:29:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:29:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:29:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:29:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:29:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['damp', 'tps']}, 08:29:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'tests': ['damp', 'tps']}, 08:29:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['dromaeo_dom']}, 08:29:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:29:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['basic_compositor_video']}, 08:29:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:29:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['a11yr', 08:29:19 INFO - 'ts_paint', 08:29:19 INFO - 'tpaint', 08:29:19 INFO - 'sessionrestore', 08:29:19 INFO - 'sessionrestore_no_auto_restore', 08:29:19 INFO - 'tabpaint']}, 08:29:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:29:19 INFO - 'ts_paint', 08:29:19 INFO - 'tpaint', 08:29:19 INFO - 'sessionrestore', 08:29:19 INFO - 'sessionrestore_no_auto_restore', 08:29:19 INFO - 'tabpaint']}, 08:29:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:29:19 INFO - 'ts_paint', 08:29:19 INFO - 'tpaint', 08:29:19 INFO - 'sessionrestore', 08:29:19 INFO - 'sessionrestore_no_auto_restore', 08:29:19 INFO - 'tabpaint']}, 08:29:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:29:19 INFO - 'ts_paint', 08:29:19 INFO - 'tpaint', 08:29:19 INFO - 'sessionrestore', 08:29:19 INFO - 'sessionrestore_no_auto_restore', 08:29:19 INFO - 'tabpaint']}, 08:29:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['a11yr', 08:29:19 INFO - 'ts_paint', 08:29:19 INFO - 'tpaint', 08:29:19 INFO - 'sessionrestore', 08:29:19 INFO - 'sessionrestore_no_auto_restore', 08:29:19 INFO - 'tabpaint']}, 08:29:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['a11yr', 08:29:19 INFO - 'ts_paint', 08:29:19 INFO - 'tpaint', 08:29:19 INFO - 'sessionrestore', 08:29:19 INFO - 'sessionrestore_no_auto_restore', 08:29:19 INFO - 'tabpaint']}, 08:29:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['tsvgx', 08:29:19 INFO - 'tsvgr_opacity', 08:29:19 INFO - 'tart', 08:29:19 INFO - 'tscrollx', 08:29:19 INFO - 'cart', 08:29:19 INFO - 'tsvg_static']}, 08:29:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:29:19 INFO - 'tsvgr_opacity', 08:29:19 INFO - 'tart', 08:29:19 INFO - 'tscrollx', 08:29:19 INFO - 'cart', 08:29:19 INFO - 'tsvg_static']}, 08:29:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'talos_options': ['--disable-e10s'], 08:29:19 INFO - 'tests': ['tp5o']}, 08:29:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:29:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'talos_options': ['--disable-e10s', 08:29:19 INFO - '--xperf_path', 08:29:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:19 INFO - 'tests': ['tp5n']}, 08:29:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:29:19 INFO - 'talos_options': ['--xperf_path', 08:29:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:29:19 INFO - 'tests': ['tp5n']}}, 08:29:19 INFO - 'talos.zip': {'path': '', 08:29:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:29:19 INFO - Running post-action listener: _resource_record_post_action 08:29:19 INFO - [mozharness: 2017-01-19 16:29:19.976550Z] Finished populate-webroot step (success) 08:29:19 INFO - [mozharness: 2017-01-19 16:29:19.976668Z] Running create-virtualenv step. 08:29:19 INFO - Running pre-action listener: _resource_record_pre_action 08:29:19 INFO - Running main action method: create_virtualenv 08:29:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:29:19 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 08:29:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:29:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:29:20 INFO - Using real prefix '/tools/python27' 08:29:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:29:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:29:23 INFO - Installing pip.................done. 08:29:23 INFO - Return code: 0 08:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:29:23 INFO - Reading from file tmpfile_stdout 08:29:23 INFO - Output received: 08:29:23 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) 08:29:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:29:23 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')]} 08:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29: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', 'pip>=1.5'] in /builds/slave/test/build 08:29: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 pip>=1.5 08:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:24 INFO - 'HOME': '/Users/cltbld', 08:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:24 INFO - 'LOGNAME': 'cltbld', 08:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:24 INFO - 'MOZ_NO_REMOTE': '1', 08:29:24 INFO - 'NO_EM_RESTART': '1', 08:29:24 INFO - 'PAGER': '/bin/cat', 08:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:24 INFO - 'PWD': '/builds/slave/test', 08:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:24 INFO - 'SHELL': '/bin/bash', 08:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:24 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:24 INFO - 'USER': 'cltbld', 08:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:24 INFO - 'XPC_FLAGS': '0x0', 08:29:24 INFO - 'XPC_SERVICE_NAME': '0', 08:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:24 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 08:29:24 INFO - Cleaning up... 08:29:24 INFO - Return code: 0 08:29:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:25 INFO - 'HOME': '/Users/cltbld', 08:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:25 INFO - 'LOGNAME': 'cltbld', 08:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:25 INFO - 'MOZ_NO_REMOTE': '1', 08:29:25 INFO - 'NO_EM_RESTART': '1', 08:29:25 INFO - 'PAGER': '/bin/cat', 08:29:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:25 INFO - 'PWD': '/builds/slave/test', 08:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:25 INFO - 'SHELL': '/bin/bash', 08:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:25 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:25 INFO - 'USER': 'cltbld', 08:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:25 INFO - 'XPC_FLAGS': '0x0', 08:29:25 INFO - 'XPC_SERVICE_NAME': '0', 08:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:25 INFO - Downloading/unpacking psutil>=3.1.1 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:29:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:29 INFO - Installing collected packages: psutil 08:29:29 INFO - Running setup.py install for psutil 08:29:29 INFO - building 'psutil._psutil_osx' extension 08:29:29 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 08:29:30 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 08:29:30 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 08:29:30 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 08:29:30 INFO - building 'psutil._psutil_posix' extension 08:29:30 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 08:29:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:29:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:29:30 INFO - ^ 08:29:30 INFO - 1 warning generated. 08:29:30 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 08:29:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:29:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:29:30 INFO - Successfully installed psutil 08:29:30 INFO - Cleaning up... 08:29:30 INFO - Return code: 0 08:29:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:30 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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:30 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 08:29:30 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 08:29:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:30 INFO - 'HOME': '/Users/cltbld', 08:29:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:30 INFO - 'LOGNAME': 'cltbld', 08:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:30 INFO - 'MOZ_NO_REMOTE': '1', 08:29:30 INFO - 'NO_EM_RESTART': '1', 08:29:30 INFO - 'PAGER': '/bin/cat', 08:29:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:30 INFO - 'PWD': '/builds/slave/test', 08:29:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:30 INFO - 'SHELL': '/bin/bash', 08:29:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:30 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:30 INFO - 'USER': 'cltbld', 08:29:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:30 INFO - 'XPC_FLAGS': '0x0', 08:29:30 INFO - 'XPC_SERVICE_NAME': '0', 08:29:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:29:30 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 08:29:30 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 08:29:30 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 08:29:30 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 08:29:30 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 08:29:30 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 08:29:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:29:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:29:33 INFO - Installing collected packages: mozsystemmonitor 08:29:33 INFO - Running setup.py install for mozsystemmonitor 08:29:33 INFO - Successfully installed mozsystemmonitor 08:29:33 INFO - Cleaning up... 08:29:33 INFO - Return code: 0 08:29:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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', '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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:29: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 jsonschema==2.5.1 08:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:33 INFO - 'HOME': '/Users/cltbld', 08:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:33 INFO - 'LOGNAME': 'cltbld', 08:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:33 INFO - 'MOZ_NO_REMOTE': '1', 08:29:33 INFO - 'NO_EM_RESTART': '1', 08:29:33 INFO - 'PAGER': '/bin/cat', 08:29:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:33 INFO - 'PWD': '/builds/slave/test', 08:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:33 INFO - 'SHELL': '/bin/bash', 08:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:33 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:33 INFO - 'USER': 'cltbld', 08:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:33 INFO - 'XPC_FLAGS': '0x0', 08:29:33 INFO - 'XPC_SERVICE_NAME': '0', 08:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:29:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:37 INFO - warning: no files found matching '*.txt' 08:29:37 INFO - no previously-included directories found matching 'build' 08:29:37 INFO - no previously-included directories found matching 'dist' 08:29:37 INFO - no previously-included directories found matching '.git*' 08:29:37 INFO - Installing collected packages: jsonschema, functools32 08:29:37 INFO - Running setup.py install for functools32 08:29:37 INFO - warning: no files found matching '*.txt' 08:29:37 INFO - no previously-included directories found matching 'build' 08:29:37 INFO - no previously-included directories found matching 'dist' 08:29:37 INFO - no previously-included directories found matching '.git*' 08:29:37 INFO - Successfully installed jsonschema functools32 08:29:37 INFO - Cleaning up... 08:29:37 INFO - Return code: 0 08:29:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:37 INFO - 'HOME': '/Users/cltbld', 08:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:37 INFO - 'LOGNAME': 'cltbld', 08:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:37 INFO - 'MOZ_NO_REMOTE': '1', 08:29:37 INFO - 'NO_EM_RESTART': '1', 08:29:37 INFO - 'PAGER': '/bin/cat', 08:29:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:37 INFO - 'PWD': '/builds/slave/test', 08:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:37 INFO - 'SHELL': '/bin/bash', 08:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:37 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:37 INFO - 'USER': 'cltbld', 08:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:37 INFO - 'XPC_FLAGS': '0x0', 08:29:37 INFO - 'XPC_SERVICE_NAME': '0', 08:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:29:37 INFO - Cleaning up... 08:29:37 INFO - Return code: 0 08:29:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:37 INFO - 'HOME': '/Users/cltbld', 08:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:37 INFO - 'LOGNAME': 'cltbld', 08:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:37 INFO - 'MOZ_NO_REMOTE': '1', 08:29:37 INFO - 'NO_EM_RESTART': '1', 08:29:37 INFO - 'PAGER': '/bin/cat', 08:29:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:37 INFO - 'PWD': '/builds/slave/test', 08:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:37 INFO - 'SHELL': '/bin/bash', 08:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:37 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:37 INFO - 'USER': 'cltbld', 08:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:37 INFO - 'XPC_FLAGS': '0x0', 08:29:37 INFO - 'XPC_SERVICE_NAME': '0', 08:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:38 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 08:29:38 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 08:29:38 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 08:29:38 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 08:29:38 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 08:29:38 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 08:29:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:29:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29:41 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 08:29:41 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 08:29:41 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 08:29:41 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 08:29:41 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 08:29:41 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 08:29:41 INFO - Downloading docopt-0.6.1.tar.gz 08:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:41 INFO - Running setup.py install for blobuploader 08:29:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:42 INFO - Running setup.py install for requests 08:29:42 INFO - Running setup.py install for docopt 08:29:42 INFO - Successfully installed blobuploader requests docopt 08:29:42 INFO - Cleaning up... 08:29:42 INFO - Return code: 0 08:29:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29: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')]} 08:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:42 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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:42 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 08:29:42 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 08:29:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:42 INFO - 'HOME': '/Users/cltbld', 08:29:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:42 INFO - 'LOGNAME': 'cltbld', 08:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:42 INFO - 'MOZ_NO_REMOTE': '1', 08:29:42 INFO - 'NO_EM_RESTART': '1', 08:29:42 INFO - 'PAGER': '/bin/cat', 08:29:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:42 INFO - 'PWD': '/builds/slave/test', 08:29:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:42 INFO - 'SHELL': '/bin/bash', 08:29:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:42 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:42 INFO - 'USER': 'cltbld', 08:29:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:42 INFO - 'XPC_FLAGS': '0x0', 08:29:42 INFO - 'XPC_SERVICE_NAME': '0', 08:29:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-1Z8Ujs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-MrKJnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-GIIvcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-65eDcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-alyuGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-4VAJIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-l_dPS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-kPjKZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:43 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-TJja_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-UM6W5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-7DLZYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-3TBgLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-FneP8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-3kAWd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-0mXw9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-yg1cza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:44 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-NGgoOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:44 INFO - Running setup.py install for manifestparser 08:29:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:45 INFO - Running setup.py install for mozcrash 08:29:45 INFO - Running setup.py install for mozdebug 08:29:45 INFO - Running setup.py install for mozdevice 08:29:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:29:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:45 INFO - Running setup.py install for mozfile 08:29:45 INFO - Running setup.py install for mozhttpd 08:29:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:45 INFO - Running setup.py install for mozinfo 08:29:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:45 INFO - Running setup.py install for mozInstall 08:29:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Running setup.py install for mozleak 08:29:46 INFO - Running setup.py install for mozlog 08:29:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Running setup.py install for moznetwork 08:29:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Running setup.py install for mozprocess 08:29:46 INFO - Running setup.py install for mozprofile 08:29:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:46 INFO - Running setup.py install for mozrunner 08:29:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:47 INFO - Running setup.py install for mozscreenshot 08:29:47 INFO - Running setup.py install for moztest 08:29:47 INFO - Running setup.py install for mozversion 08:29:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:47 INFO - Cleaning up... 08:29:47 INFO - Return code: 0 08:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:47 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')]} 08:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:47 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')]} 08:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:47 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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:47 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 08:29:47 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 08:29:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:47 INFO - 'HOME': '/Users/cltbld', 08:29:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:47 INFO - 'LOGNAME': 'cltbld', 08:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:47 INFO - 'MOZ_NO_REMOTE': '1', 08:29:47 INFO - 'NO_EM_RESTART': '1', 08:29:47 INFO - 'PAGER': '/bin/cat', 08:29:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:47 INFO - 'PWD': '/builds/slave/test', 08:29:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:47 INFO - 'SHELL': '/bin/bash', 08:29:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:47 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:47 INFO - 'USER': 'cltbld', 08:29:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:47 INFO - 'XPC_FLAGS': '0x0', 08:29:47 INFO - 'XPC_SERVICE_NAME': '0', 08:29:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:47 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-HBd2lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:47 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)) 08:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:47 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-_7ImqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-XYeVyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-pRqglU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-fiHI77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-4LEFo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-uZK22Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-kvBorY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-0TYH82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-f1LkCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:48 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)) 08:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:48 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-NsJGyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:49 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)) 08:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:49 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-6r7X9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:49 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-ThNT0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:49 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)) 08:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:49 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-gJttmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:49 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)) 08:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:49 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-_NSFHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:49 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)) 08:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:49 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-_YLlXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:49 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)) 08:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:49 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-nHsODP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:49 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)) 08:29:49 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)) 08:29:49 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)) 08:29:49 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)) 08:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:29:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:49 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 08:29:49 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 08:29:49 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 08:29:49 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 08:29:49 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 08:29:49 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 08:29:52 INFO - Downloading blessings-1.6.tar.gz 08:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:52 INFO - Installing collected packages: blessings 08:29:52 INFO - Running setup.py install for blessings 08:29:52 INFO - Successfully installed blessings 08:29:52 INFO - Cleaning up... 08:29:52 INFO - Return code: 0 08:29:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:53 INFO - Reading from file tmpfile_stdout 08:29:53 INFO - Current package versions: 08:29:53 INFO - blessings == 1.6 08:29:53 INFO - blobuploader == 1.2.4 08:29:53 INFO - docopt == 0.6.1 08:29:53 INFO - functools32 == 3.2.3-2 08:29:53 INFO - jsonschema == 2.5.1 08:29:53 INFO - manifestparser == 1.1 08:29:53 INFO - mozInstall == 1.12 08:29:53 INFO - mozcrash == 1.0 08:29:53 INFO - mozdebug == 0.1 08:29:53 INFO - mozdevice == 0.49 08:29:53 INFO - mozfile == 1.2 08:29:53 INFO - mozhttpd == 0.7 08:29:53 INFO - mozinfo == 0.9 08:29:53 INFO - mozleak == 0.1 08:29:53 INFO - mozlog == 3.4 08:29:53 INFO - moznetwork == 0.27 08:29:53 INFO - mozprocess == 0.24 08:29:53 INFO - mozprofile == 0.28 08:29:53 INFO - mozrunner == 6.13 08:29:53 INFO - mozscreenshot == 0.1 08:29:53 INFO - mozsystemmonitor == 0.3 08:29:53 INFO - moztest == 0.8 08:29:53 INFO - mozversion == 1.4 08:29:53 INFO - psutil == 3.1.1 08:29:53 INFO - requests == 1.2.3 08:29:53 INFO - wsgiref == 0.1.2 08:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:53 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')]} 08:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:53 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')]} 08:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:53 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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:53 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 08:29:53 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 08:29:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:53 INFO - 'HOME': '/Users/cltbld', 08:29:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:53 INFO - 'LOGNAME': 'cltbld', 08:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:53 INFO - 'MOZ_NO_REMOTE': '1', 08:29:53 INFO - 'NO_EM_RESTART': '1', 08:29:53 INFO - 'PAGER': '/bin/cat', 08:29:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:53 INFO - 'PWD': '/builds/slave/test', 08:29:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:53 INFO - 'SHELL': '/bin/bash', 08:29:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:53 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:53 INFO - 'USER': 'cltbld', 08:29:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:53 INFO - 'XPC_FLAGS': '0x0', 08:29:53 INFO - 'XPC_SERVICE_NAME': '0', 08:29:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 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)) 08:29:53 INFO - Cleaning up... 08:29:53 INFO - Return code: 0 08:29:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:53 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')]} 08:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:53 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')]} 08:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:53 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 0x10d661b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83a155ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, '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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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 08:29:53 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 08:29:53 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 08:29:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:29:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:53 INFO - 'HOME': '/Users/cltbld', 08:29:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:53 INFO - 'LOGNAME': 'cltbld', 08:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:53 INFO - 'MOZ_NO_REMOTE': '1', 08:29:53 INFO - 'NO_EM_RESTART': '1', 08:29:53 INFO - 'PAGER': '/bin/cat', 08:29:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:53 INFO - 'PWD': '/builds/slave/test', 08:29:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:53 INFO - 'SHELL': '/bin/bash', 08:29:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:29:53 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:29:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:53 INFO - 'USER': 'cltbld', 08:29:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:53 INFO - 'XPC_FLAGS': '0x0', 08:29:53 INFO - 'XPC_SERVICE_NAME': '0', 08:29:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:53 INFO - Cleaning up... 08:29:53 INFO - Return code: 0 08:29:53 INFO - Running post-action listener: _resource_record_post_action 08:29:53 INFO - Running post-action listener: _start_resource_monitoring 08:29:53 INFO - Starting resource monitoring. 08:29:53 INFO - [mozharness: 2017-01-19 16:29:53.629359Z] Finished create-virtualenv step (success) 08:29:53 INFO - [mozharness: 2017-01-19 16:29:53.630286Z] Running install step. 08:29:53 INFO - Running pre-action listener: _resource_record_pre_action 08:29:53 INFO - Running main action method: install 08:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:53 INFO - Reading from file tmpfile_stdout 08:29:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:53 INFO - Reading from file tmpfile_stdout 08:29:53 INFO - Output received: 08:29:53 INFO - Usage: mozinstall [options] installer 08:29:53 INFO - Options: 08:29:53 INFO - -h, --help show this help message and exit 08:29:53 INFO - -d DEST, --destination=DEST 08:29:53 INFO - Directory to install application into. [default: 08:29:53 INFO - "/builds/slave/test"] 08:29:53 INFO - --app=APP Application being installed. [default: firefox] 08:29:53 INFO - mkdir: /builds/slave/test/build/application 08:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:30:16 INFO - Reading from file tmpfile_stdout 08:30:16 INFO - Output received: 08:30:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:30:16 INFO - Running post-action listener: _resource_record_post_action 08:30:16 INFO - [mozharness: 2017-01-19 16:30:16.114508Z] Finished install step (success) 08:30:16 INFO - [mozharness: 2017-01-19 16:30:16.114635Z] Running run-tests step. 08:30:16 INFO - Running pre-action listener: _resource_record_pre_action 08:30:16 INFO - Running main action method: run_tests 08:30:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:16 INFO - 2017-01-19 08:30:16.129 screenresolution[1626:7488] starting screenresolution argv=screenresolution get 08:30:16 INFO - 2017-01-19 08:30:16.131 screenresolution[1626:7488] Display 0: 1600x1200x32@60 08:30:16 INFO - 2017-01-19 08:30:16.137 screenresolution[1627:7490] starting screenresolution argv=screenresolution list 08:30:16 INFO - Available Modes on Display 0 08:30:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:16 INFO - Intel Iris: 08:30:16 INFO - Chipset Model: Intel Iris 08:30:16 INFO - Type: GPU 08:30:16 INFO - Bus: Built-In 08:30:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:30:16 INFO - Vendor: Intel (0x8086) 08:30:16 INFO - Device ID: 0x0a2e 08:30:16 INFO - Revision ID: 0x0009 08:30:16 INFO - Displays: 08:30:16 INFO - Display: 08:30:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:16 INFO - Display Serial Number: 1600x1200 60 08:30:16 INFO - Main Display: Yes 08:30:16 INFO - Mirror: Off 08:30:16 INFO - Online: Yes 08:30:16 INFO - Rotation: Supported 08:30:16 INFO - Return code: 0 08:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:30:16 INFO - Python 2.7.3 08:30:16 INFO - Return code: 0 08:30:16 INFO - grabbing minidump binary from tooltool 08:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43fd30>, '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 0x10d366db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d434be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:30:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:30:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:30:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:30:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:30:16 INFO - Return code: 0 08:30:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:30:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:30:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:30:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:30:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:30:16 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/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0236', '--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 08:30:16 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/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0236 --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 08:30:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qgAx2fe5J7/Render', 08:30:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:30:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:30:16 INFO - 'HOME': '/Users/cltbld', 08:30:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:30:16 INFO - 'LOGNAME': 'cltbld', 08:30:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:30:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:30:16 INFO - 'MOZ_NO_REMOTE': '1', 08:30:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:30:16 INFO - 'NO_EM_RESTART': '1', 08:30:16 INFO - 'PAGER': '/bin/cat', 08:30:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:30:16 INFO - 'PWD': '/builds/slave/test', 08:30:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:30:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:30:16 INFO - 'SHELL': '/bin/bash', 08:30:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ibgrSvBX1E/Listeners', 08:30:16 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 08:30:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:30:16 INFO - 'USER': 'cltbld', 08:30:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:30:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:30:16 INFO - 'XPC_FLAGS': '0x0', 08:30:16 INFO - 'XPC_SERVICE_NAME': '0', 08:30:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:30:16 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/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0236', '--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 08:30:16 INFO - mozversion application_buildid: 20170119071129 08:30:16 INFO - mozversion application_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 08:30:16 INFO - mozversion application_display_name: Nightly 08:30:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:30:16 INFO - mozversion application_name: Firefox 08:30:16 INFO - mozversion application_remotingname: firefox 08:30:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:30:16 INFO - mozversion application_vendor: Mozilla 08:30:16 INFO - mozversion application_version: 53.0a1 08:30:16 INFO - mozversion platform_buildid: 20170119071129 08:30:16 INFO - mozversion platform_changeset: a3978751f45108ff1ae002ecebdc0fa23fc52b84 08:30:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:30:16 INFO - mozversion platform_version: 53.0a1 08:30:16 INFO - using testdate: 1484843416 08:30:16 INFO - actual date: 1484843416 08:30:16 INFO - starting webserver on 'localhost:49240' 08:30:16 INFO - SUITE-START | Running 2 tests 08:30:16 INFO - TEST-START | dromaeo_css 08:30:16 INFO - operating with platform_type : mac_ 08:30:16 INFO - Initialising browser for dromaeo_css test... 08:30:16 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpqnsxku/profile http://localhost:49240/getInfo.html) 08:30:19 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 08:30:19 INFO - PROCESS | 1637 | colorDepth:24 08:30:19 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 08:30:19 INFO - PROCESS | 1637 | __metrics 08:30:19 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:30:19 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:20 INFO - TEST-INFO | 1637: exit 0 08:30:20 INFO - Browser initialized. 08:30:20 INFO - Running cycle 1/1 for dromaeo_css test... 08:30:20 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpqnsxku/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:32 INFO - PROCESS | 1639 | RSS: Main: 226865152 08:30:32 INFO - PROCESS | 1639 | 08:33:35 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:33:38 INFO - PROCESS | 1639 | RSS: Main: 449875968 08:33:38 INFO - PROCESS | 1639 | 08:35:21 INFO - PROCESS | 1639 | ************************* 08:35:21 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 08:35:21 INFO - PROCESS | 1639 | 08:35:21 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:35:21 INFO - PROCESS | 1639 | Full stack: 08:35:21 INFO - PROCESS | 1639 | ************************* 08:36:41 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:36:42 INFO - PROCESS | 1639 | RSS: Main: 366374912 08:36:42 INFO - PROCESS | 1639 | 08:39:44 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:39:45 INFO - PROCESS | 1639 | RSS: Main: 337616896 08:39:45 INFO - PROCESS | 1639 | 08:42:47 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:42:48 INFO - PROCESS | 1639 | RSS: Main: 329252864 08:42:48 INFO - PROCESS | 1639 | 08:45:51 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:45:52 INFO - PROCESS | 1639 | RSS: Main: 332279808 08:45:52 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:48:55 INFO - PROCESS | 1639 | RSS: Main: 423292928 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | __start_tp_report 08:48:55 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:48:55 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:48:55 INFO - PROCESS | 1639 | |i|pagename|runs| 08:48:55 INFO - PROCESS | 1639 | |0;dojo.html;3264.314493956269;3276.164578032601;3290.1445624137723;3306.6442758469034;3351.8156501392427;5532.723363831812;5575.330960284761;5603.439656034395;5608.495235428815;5631.8028868989595;5583.469570390816;5621.887562248752;5710.257666503348;5719.799807006755;5723.5135013523795;5027.421846487664;5088.491150884919;5141.357330333708;5159.71621560814;5163.483651634844;5202.219667049935;5210.114280572293;5218.582513398938;5230.293910322096;5257.316548848645;5143.459936706667;5164.45773193813;5186.040582492251;5199.6360254782185;5202.739863006854;5019.247112933089;5065.164247899129;5083.694978301313;5095.668781529226;5099.235114732783;4200.7479551227025;5083.949160508385;5134.0758663440565;5163.509466600704;5183.81856635016;5598.804041858515;5600.243967064435;5600.299962504687;5605.663660180361;5606.21512988182;6024.126501657279;6144.5698801083945;6192.071189321593;6194.94685903393;6196.442320191204;6130.080487926802;6143.84640383994;6160.353162917919;6191.628502289877;6206.6586337751405;5737.995850726106;5748.310202775652;5751.827445176651;5769.134629805562;5787.218725472049;5908.20239267702;6283;6325.746970121236;6330.1454303668415;6339.302676705559;5938.198343223609;5977.970110149508;5978.85052873673;6011.849703757353;6016.398360164036;6040.697965101727;6083.695815209222;6113.576218238259;6187.16473276111;6190.102435146879;5987.850303742354;5999.7900073498095;6004.099385092271;6008.759649613967;6012.549058820606;5220.399654039834;6104.4200800923845;6137.8187520601;6195.473384762346;6212.316645169119;4879.1461494238365;4891.364122664102;4891.6575839691595;4906.279520707957;4913.852584422473;4359.67302452311;4376.737395756265;4422.159789639958;4423.314386270134;4464.665150113755;4706.317583950308;5635.126555383922;5635.718214089361;5657.953278643382;5664.2636457261115;6237.064440333987;6238.844028899314;6251.812445626639;6254.249490061131;6256.124142620037;5612.915806262909;5617.269754931833;5647.858803529944;5679.545636349082;5697.686627235459;5163.199704045879;5190.740462976912;5205.089109405839;5314.0700377433795;5338.91991620126;6293.937060629335;6300.928842096946;6303.432691057827;6333.524985626004;6335.493160547053;6235.282942461675;6247.031710084944;6257.124002639725;6258.718357673824;6263.467605253604;6234.470070043915;6237.438630523275;6278.968605156945;6279.026750853625;6287.993920972623;6074.1799857020505;6084.726187321493;6086.6652334122045;6147.44672979434;6163;6239.126522286792;6248.187735594343;6255.061740738925;6262.68686565679;6264.342244064308;5975.462208401264;5987.700614969147;6032.638041717511;6038.5772995889865;6068.666223357581;5853.678047707417;5918.822435326947;5956.880862382642;5968.313643931004;6003.429674180946;5451.591130665295;5876.1773351729935;5880.088586269135;5893.057110862242;5893.823185304448;5883.323417806836;5947.137665038632;5955.493783028318;5998.550108741949;6047.213862197887;5754.136879467946;5827.504662103769;5829.5336373090895;5830.650160990354;5841.620294680833 08:48:55 INFO - PROCESS | 1639 | |1;ext.html;495.3238828998418;501.36827597227494;505.93675790526186;509.1878453866082;513.9511746384093;40747.38878916815;42120.57879421205;42438.363424548654;42642.360364594555;44783.32825007627;44094.11811763771;44494.88762780932;44503.77748111255;44641.330380044325;44732.55267447325;8424.957875210615;9325.766855828608;9514.33399662024;9517.23862091031;9536.570854311538;8441.535715535674;9222.907770922271;11371.772564548704;11384.373859437728;11541.596044138458;11144.498497567589;11170.93337732522;11185.66443006707;11195.4962026709;11201.66395008151;8435.198656127657;8673.522956237404;11349;11441.59954401596;11480.885191148065;11018;11327.037201837853;11337.489812958436;11523.42382880861;11537.94231028848;41781.79109104465;42089.1582168358;42090.789546052074;42097.579024209976;42172.57827421717;4068.1456894052285;4090.406891000788;4106.856260030914;4123.9175216495505;4226.830926762926;30074.39851202964;30604.693953060407;30703.385932281453;30812.38375232505;31440.842795786102;3092.0667083842486;3215.469447541176;3246.2209069823307;3253.186703324169;3276.475763877792;432762;433443;434231;435168;435190;61560;61909.690451548355;61937.38062619406;61945.070823937676;62240.37759622437;65187.34812651908;65451;65465.672671636334;65572.67213663901;65884.67057664681;15552.989055711343;16125.919370403073;16126.145493268425;16132.032078075354;16145.273462693973;11159.27464714791;11472.94263528677;11530.308181509135;12404.875951240372;12540.184887982434;15910.443134490237;16400.589985250463;17321.65356692859;17452.47642570725;17499.475015749547;7282.854342913112;7298.671559779823;7327.0841144856895;7347.88978165328;7349.30181632744;886.5389997201419;894.7986702991775;898.5372533145435;924.9861252081224;941.1858742187958;29990.850045750067;30023.549646755317;30182.698173018427;30755.84883023404;30816.229594259876;1060.2525219720078;1066.8879767624444;1067.8718553773597;1113.6158025481195;1116.9891248420192;15485.148316842457;15486.5354039379;15824.92087539555;15919.442819501262;16403.261853216634;621993;638175;639017;641006;642439;62131;62659;62704;62767;62913.68543157347;1489.7690857917041;1500.1149321900132;1507.2765072765135;1543.691261747655;1549.1634517360724;23186.95658695329;25629.3592660185;27598.4820834848;28819.56770648484;30094.69905300919;54364.18453723118;55074;55211.723941380034;55337.72331138318;55361.16958245549;447894;482758.58620708075;502404;503109;503477;35848.235935226425;41047.89521047872;42074.36888446737;42666.360004600574;43077.56922430736;44780.55219447894;45353.092938141715;45402.54597454115;49199;49385.753071234416;35531.36716941114;37043.88868333847;37071.81464092662;37751;38267.808660956514;35905.28189436145;36017.459738103425;36495.63504365028;37369.6263037377;37510.62489375071;36277.637223627426;36619.53521859096;36968.26063478662;37185;37265.441018384205;23772.881135594213;26111.30660613501;28135.296617584725;28792.280192995342;32924.835375823925;23698.644520332553;24094.51810963736;24268.254340567804;24528.01887924463;24692.876535617208 08:48:55 INFO - PROCESS | 1639 | |2;jquery.html;362.1652091928105;363.40945962810434;390.8885967499265;399.109984734043;411.47947845974863;16137.435189768346;20652.48368790781;21019.36941891742;21144.8942755286;21300;21112.366629001117;21646.567068658616;21677.45806354842;21840.890795546;22104.778952210472;5816.272965879265;5893.145493903381;6028.156058151862;6101.481374083208;6104;4257.40396344512;4445;4448.110377924412;5953.464188223059;6071.453569178773;6401.615903045832;6664.233613134479;6721.361470660304;6794.524383293171;6796.592204467748;5785.710714464281;6053.940560401956;6122.081687746873;6149.385061493815;6740.460763138937;5832.6500409975115;5995.730192141364;6009;6010.338862725097;6010.819675409744;13421.86578134216;13764.17414955106;13772.793408098887;13797;16807.83192168087;2632.8288661236957;2633.5259653262406;2677.290518012728;2691.1926422073298;2746.395792925553;9615.806368004402;9960.25298102638;10417.27079104463;10460.738481537946;10551.050405463546;1797.2541395320927;1834.4038187588953;1834.9816501834944;1844.0687452836366;1845.446366090181;114549;117852.99999999914;138547.30726346406;144047;144293.55706442907;11579.942100289612;11795.764084718257;12046.518139274505;12170.57402990891;12177.634670959886;15365.6158596036;15369.308381122877;15642.983206091567;15733.527994160193;15775.842241577437;8403;8655.826883462421;8660.78348041304;8794.780130496662;8841.16008979146;7249.855002900018;8434.287857329586;8607.225349718556;8681.56592170389;8774.254188394058;4758.762061896891;4768.094062128184;4789;4796.664233503621;4841.958978819571;1578.873690104789;1655.337864854068;1659.029467761373;1848.879822811513;2002.5093852006353;974.8050389922043;1014.5434554450379;1021.7241344836852;1023.150784848574;1082.3451811653836;19300.90349548243;21428.464288392603;21538.492275572065;21550;21955.341339759834;906.6146887572755;1034.7826956339254;1038.2680210451765;1081.9459027048774;1089.5968491658136;11106.888931110747;11467.254628449291;11489.42552872353;11495.770084598262;11510.136739744552;589902;651682;701209;727353;728043.3597831976;146314;149596;150590;152169.23915380353;153275;1036.4144258493927;1063.5320458998017;1064.297563608015;1082.5182793656747;1088.7985722641338;18583.792053516478;19226.230950761812;20075.498112547302;20167;20180.697289540964;54479.18281225706;60740.69629651823;61967.07049394353;62581.374186257555;62751.6862415685;86325;87106;87213;88792.5560372194;90216.548917255;8368.414211005414;8379.162083791573;8505.74482765518;8580.270676992526;8632.395732298679;12178.57374991871;13168.80246796318;13234.272115033766;13702.93148534251;13719.862801371859;9791.51042447889;10845;11071.612493562687;11099.500522476346;11535.653930382103;10474;11179.66461006171;11223.438828058728;11578.884211157781;11595.362255075714;11526.769464610494;11798.764024719287;11822.645320640395;11993.460294286604;12077.335746533674;8186.959065204635;8384.706535271236;8469.534175620154;8489.193526614961;8523.91476085256;8956.417832840845;11305.26515776472;11342.886571134182;11517.827232591686;11573.710657233636 08:48:55 INFO - PROCESS | 1639 | |3;mootools.html;1436.2172615924321;1472.1755816742625;1473.3222717549927;1495.0805254768318;1500.5648361975027;7985.760427187186;8393.748187554376;8402.705905293316;8411.242988131067;8413;7407.814804629874;7649.502782319159;7928.246816552432;8207.83584328313;8248.711295104673;2267.1951457232735;2313.3869524576003;2317.5249073939885;2320.1299512682745;2322.1872344679314;2310.745817960023;2331.94170145746;2337.1586228957563;2337.4740683346195;2348.7064116985375;2215.080741492279;2259.9886101369793;2275.6927814744963;2299.287220961499;2300.8734519601417;2250.6173950428465;2262.7058482397347;2267.1498188179517;2274.0789980058103;2274.6815445837597;2207.9006444710026;2298.138198175684;2298.5402919416183;2299.471121642015;2305.0549274797254;8308.418410711252;8363.916360836374;8367.372447066495;8373.204545568162;8375.246227839463;5019.498050194988;5067.239914012891;5071.29001939725;5184.870378240536;5193.68837869729;2947.82313061217;3246.1397729601676;3325.551050608161;3458.066322093046;3497.0383144635175;1204.2172587817902;1211.5517258614282;1239.876012398762;1252.0797214047668;1254.1910467748341;10183.490825458697;10287.485625718758;10291.53688084038;10322.329048611891;10335.94832025835;4247.299195632686;4259.297215959394;4330.39374487572;4338.110687309158;4480.350349199413;8318.251357377743;9386.48374339418;9403.294752893424;9403.29475289356;9424.151826335663;4395.318725597537;5211.322528071327;5212.817551385683;5217.686938783685;5218.112920803473;4269.914601707948;4352.586504282088;4683.7892294846815;4784.808607655655;4789.760511974388;3758.567764707039;3782.7541209821275;3841.615838416136;3873.8837834865;3896.337622604164;1244.3031902134833;1247.4324182496941;1252.292454763056;1262.299423819789;1263.1347526944073;860.7848037990502;869.3306154261184;874.4316194473643;908.955298095567;917.7430319510547;4313.309870420718;5286.867828304323;5339.706316152571;5473.452654734495;5536.114221724505;490.73500309833;556.4491153757832;579.6174524813687;580.7067430947344;586.9706514674249;3656.5246517952496;3831.674307683878;3852.903677408031;3852.998220462644;4109;9316.254699624014;9685.661001865043;9757.658481953098;9862.605495780232;9873.456959867133;9550.37922535033;9877.160441362565;9889.60441582343;9911;9921.851172232422;7355.963220183865;7578.583177925157;7670.309672129423;7738.496997695244;7819.257170568787;5613;5621.184928185472;5717.742701578356;5720.656760594211;5881.353051164283;8399.496030238206;9056.818863622559;9150.908490915006;9266;9378.76553086151;9150.49672268005;9207.585658645243;9328.580213890527;9386.15524602789;9453;6582.736690532325;6797;6895.620740859301;7056.8588628226125;7188.209296977224;7755.185705501067;7968.482048666818;7974.40191985615;7977.760667179994;7978.920210797818;6964.050442311303;7159.534630249017;7166.140063192451;7215.963920180366;7320.707171713285;6979.965100174467;6997.615131167631;7006.334398232159;7176.282371762782;7217.927820721726;6348.873022539616;6382.553221274652;6446.7098980546925;6446.774362897276;6461.127747754181;4944.604431645532;4989.25161225819;5007.57435617962;5038.067957427887;5064.088464076502;4913.336699545515;4979.4024717032735;4987.426445958616;5051.3433253676785;5171.095058364846 08:48:55 INFO - PROCESS | 1639 | |4;prototype.html;352.52057202205;361.9891403257902;362.1597892888499;367.6617511889062;370.9035650730809;5247.212918062292;5311.875249900032;5330.920036199455;5336.172893201555;5347.518723314901;5269.710165940872;5320.521153096221;5321.893562128765;5349.9300139972065;5352.5182733553975;3461.7749846259912;3808.5239345081864;3909.511311086107;3979.7814316824115;4099.6720262379085;4030.274550580909;4122.237386083569;4128.903322508119;4139.3856396005585;4145.440365550658;3600.6399360064047;3619.2037751694584;4009.3785463253244;4135.648469880049;4192.538820729717;3462.515247865301;3929.2534418460546;3959.1289916218384;4103.363978583325;4142.337226043818;3473.774204676713;3613.0606042428894;3637;3642.526471558707;3678.301122786662;5128.281995553231;5128.435872054071;5158.303629010074;5204.531592156724;5261.447548007481;4275.444192254987;4516.7578915798085;4692.178868697964;4754.548317909793;4801.591864691505;5504.137848318892;5514.531264842453;5536.252605898192;5545.251391062236;5659.886802263932;3549.6627820357025;3725.5529336479794;3985.9507476780286;4000.079981604247;4027.3153563894207;5554.527865131468;5836.095405212199;5875.059990401515;5899.970500147515;5942.940570594325;3819.4270859370763;3832.329342365075;3845.8461661533224;3862.24686186191;3872.186840763471;3393.0499460151195;3745.4418302612626;3892.766434013968;3927.430522574211;3931.331673615492;4257.616814486649;4542.750148741851;4546.953541127453;4581.908361832745;4584.472785629629;4541.683741291965;4777.928331075037;5611.494965453129;5650.378458369576;5713.628614140068;1153.3541216918552;1166.988330116705;1229.305442425027;1244.0545185658964;1285.395863943945;822.9466283157568;856.7491462464747;868.6699054359303;875.8773771671971;878.9077146899612;4647.256438969748;4865.270209468608;4870.707757534559;4894.531640507905;4917.237828136645;4896.436909755424;4912.361393018885;4981.452040275567;5243.344581927259;5418.647787893774;3937.9803100984313;4382.780860956939;4909.558139767367;4921.3602231710365;4934.309196712463;2427.5994460913753;2484.90664107792;2513.9371515712255;2705.971730742305;2869.110575721533;4938.357978481496;5281.498257665516;5667.291588551431;5675;5734.168545560954;4735.360726301974;5014.598832093497;5315.840524784263;5406.54044406222;5410.594205434608;4951.356323677899;5868.212599015605;5908.911366329508;5947.940520594739;5954.541137421359;4949.727764972961;5660.914801433147;5707.400722924199;5710.571707122065;5778.682172480554;4910.459849416633;5357.330333708286;5640.943590564042;5749.655020698771;5813.157092221689;4884;5287.629865909349;6076.817695469143;6123.84690382744;6142.358785722183;3829.789361585028;3910.1788624389196;3918.4318273850704;3942.546607140101;3943.8422463101156;5451.454854514517;5694.202811606296;5724.771009159587;5771.59598828078;5788.652680839163;4955.603551715926;5240.2663627093;5269.920951185812;5652.943470565242;5653.858653533694;4156.646685031807;4798.23228283473;4965.4289756678445;5623;5626.662400255997;5264.236480778829;5306.310179676618;5346.518813306821;5379.273798037215;5473.768402109494;5077.949220507895;5513.283273174462;5588.804391846266;5594;5597.888042239214;4803.831865884677;5191.714455704972;5220.869478263074;5428.430014848384;5519.337679478488 08:48:55 INFO - PROCESS | 1639 | |5;yui.html;716.5664772812445;739.2828955912767;762.051246198483;817.337956255433;860.948343099414;14747.631309217262;15270.16014119223;15558.688826223468;15652.295646695897;16020.59948501288;14267.286635668226;14468.710625787478;14632.41470341185;14859.405623775036;14860.256987150626;866.960986755596;889.4440974391006;890.3945317184312;892.1970226795871;893.7676204186894;688.490517017406;714.7033980897921;717.4511498703496;879.3888247667874;881.3918396306528;895.6327905558722;934.4019827310527;939.4316438554679;940.6613619097119;941.016637613692;891.4829398948594;925.0934084597098;926.9953650231773;928.215657769184;928.7724507495707;530.5490333216774;664.6510581944469;665.0058163046228;679.3953381490477;690.378659206713;12362.690932726664;14565.126092434488;15104.773428398583;15160.014599051026;15360.615984600363;14344.282785860665;14354.64113397163;14432;14509.347079381454;14527.418903243857;11914.106442016884;11929.164958452911;11999.400029998465;12154.939225303906;12157.574484893075;3686.8340924658455;3715.758475699071;3744.7753134811996;3756.0609847538117;3758.830852611639;104489;106839.46580267049;106906.93093069048;107603;107683;11249.94375028136;11304.434778261055;11390.37352945596;11486.310821350746;11579.88420115805;23903.163389281293;23949.28152155438;24177.395565111012;24201.152959646326;24438.389040274134;7823.061232652118;7828.647710852912;7831.569263690438;7853.646585903648;8066.919330806617;4206.305959516707;4320.222359975234;4334.913301734011;4371.628411584988;4488.259437192892;3616.9819150904077;3725.869594564177;3729.850805967731;3733.701303895682;3737.981310093432;543.9075357189288;566.4250785452768;624.569047357322;625.8873402787542;632.5603705424686;688.896665500169;701.3792793377897;708.6208878250111;722.9746958856415;750.8535835512023;9749.805003899883;10161.644342447978;10183.236257280734;10212.489375531342;10544.630937917136;614.757170917485;639.1946147853738;643.4144928115393;647.2039391548328;648.2091847945499;4738.573528382393;4992.425871024879;5012.8496145115705;5032.094223039815;5033.974830125826;104887;107861;109687;109990;110392;76418;94937.55419777427;95422.52288738512;97974.51012744891;99563.00436995682;83047.58476207701;83068.16931830604;84448;84573.57713211395;86057;9296.95351523238;9461.290403219647;9693.352234574293;9704.805903882025;9766.60933562678;54242.728786355816;54992.17511737247;55274;56030.90284891924;56121.71939140278;71128.64435677789;73973;75089.24910750822;75271.62364188144;76787;9918.950405247928;9938.938281918092;11725.941370293094;12017.699557511132;12383.133180677267;12464.189827661174;12816;12841.486340546273;13062.281574513492;13442.93278533601;12005.39973001364;12017.218880772722;12020.218685785396;12048.879511204776;12072.275663460221;11805.586804461802;12000.879991199976;12127;12228.510859565518;12564.057695672678;11834.940825296162;11895.940520297343;11962.76074478523;12456.377181141088;12458.31479268649;8485;9644.469554174588;9939.503024848873;10135.442550659785;10255.159194443813;8489.791858354165;9215;9741.366811157252;9756.46339451337;9837.114659680663 08:48:55 INFO - PROCESS | 1639 | __end_tp_report 08:48:55 INFO - PROCESS | 1639 | __start_cc_report 08:48:55 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,2496 08:48:55 INFO - PROCESS | 1639 | __end_cc_report 08:48:55 INFO - PROCESS | 1639 | __startTimestamp1484844535370__endTimestamp 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:48:55 INFO - PROCESS | 1639 | Number of tests: 6 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5659.05 Median:5853.68 stddev:648.67 (11.1%) stddev-sans-first:622.86 08:48:55 INFO - PROCESS | 1639 | Values: 3264.3 3276.2 3290.1 3306.6 3351.8 5532.7 5575.3 5603.4 5608.5 5631.8 5583.5 5621.9 5710.3 5719.8 5723.5 5027.4 5088.5 5141.4 5159.7 5163.5 5202.2 5210.1 5218.6 5230.3 5257.3 5143.5 5164.5 5186.0 5199.6 5202.7 5019.2 5065.2 5083.7 5095.7 5099.2 4200.7 5083.9 5134.1 5163.5 5183.8 5598.8 5600.2 5600.3 5605.7 5606.2 6024.1 6144.6 6192.1 6194.9 6196.4 6130.1 6143.8 6160.4 6191.6 6206.7 5738.0 5748.3 5751.8 5769.1 5787.2 5908.2 6283.0 6325.7 6330.1 6339.3 5938.2 5978.0 5978.9 6011.8 6016.4 6040.7 6083.7 6113.6 6187.2 6190.1 5987.9 5999.8 6004.1 6008.8 6012.5 5220.4 6104.4 6137.8 6195.5 6212.3 4879.1 4891.4 4891.7 4906.3 4913.9 4359.7 4376.7 4422.2 4423.3 4464.7 4706.3 5635.1 5635.7 5658.0 5664.3 6237.1 6238.8 6251.8 6254.2 6256.1 5612.9 5617.3 5647.9 5679.5 5697.7 5163.2 5190.7 5205.1 5314.1 5338.9 6293.9 6300.9 6303.4 6333.5 6335.5 6235.3 6247.0 6257.1 6258.7 6263.5 6234.5 6237.4 6279.0 6279.0 6288.0 6074.2 6084.7 6086.7 6147.4 6163.0 6239.1 6248.2 6255.1 6262.7 6264.3 5975.5 5987.7 6032.6 6038.6 6068.7 5853.7 5918.8 5956.9 5968.3 6003.4 5451.6 5876.2 5880.1 5893.1 5893.8 5883.3 5947.1 5955.5 5998.6 6047.2 5754.1 5827.5 5829.5 5830.7 5841.6 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:66759.07 Median:38009.40 stddev:140427.49 (369.5%) stddev-sans-first:140733.29 08:48:55 INFO - PROCESS | 1639 | Values: 495.3 501.4 505.9 509.2 514.0 40747.4 42120.6 42438.4 42642.4 44783.3 44094.1 44494.9 44503.8 44641.3 44732.6 8425.0 9325.8 9514.3 9517.2 9536.6 8441.5 9222.9 11371.8 11384.4 11541.6 11144.5 11170.9 11185.7 11195.5 11201.7 8435.2 8673.5 11349.0 11441.6 11480.9 11018.0 11327.0 11337.5 11523.4 11537.9 41781.8 42089.2 42090.8 42097.6 42172.6 4068.1 4090.4 4106.9 4123.9 4226.8 30074.4 30604.7 30703.4 30812.4 31440.8 3092.1 3215.5 3246.2 3253.2 3276.5 432762.0 433443.0 434231.0 435168.0 435190.0 61560.0 61909.7 61937.4 61945.1 62240.4 65187.3 65451.0 65465.7 65572.7 65884.7 15553.0 16125.9 16126.1 16132.0 16145.3 11159.3 11472.9 11530.3 12404.9 12540.2 15910.4 16400.6 17321.7 17452.5 17499.5 7282.9 7298.7 7327.1 7347.9 7349.3 886.5 894.8 898.5 925.0 941.2 29990.9 30023.5 30182.7 30755.8 30816.2 1060.3 1066.9 1067.9 1113.6 1117.0 15485.1 15486.5 15824.9 15919.4 16403.3 621993.0 638175.0 639017.0 641006.0 642439.0 62131.0 62659.0 62704.0 62767.0 62913.7 1489.8 1500.1 1507.3 1543.7 1549.2 23187.0 25629.4 27598.5 28819.6 30094.7 54364.2 55074.0 55211.7 55337.7 55361.2 447894.0 482758.6 502404.0 503109.0 503477.0 35848.2 41047.9 42074.4 42666.4 43077.6 44780.6 45353.1 45402.5 49199.0 49385.8 35531.4 37043.9 37071.8 37751.0 38267.8 35905.3 36017.5 36495.6 37369.6 37510.6 36277.6 36619.5 36968.3 37185.0 37265.4 23772.9 26111.3 28135.3 28792.3 32924.8 23698.6 24094.5 24268.3 24528.0 24692.9 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:38685.81 Median:21364.23 stddev:114105.89 (534.1%) stddev-sans-first:114389.70 08:48:55 INFO - PROCESS | 1639 | Values: 362.2 363.4 390.9 399.1 411.5 16137.4 20652.5 21019.4 21144.9 21300.0 21112.4 21646.6 21677.5 21840.9 22104.8 5816.3 5893.1 6028.2 6101.5 6104.0 4257.4 4445.0 4448.1 5953.5 6071.5 6401.6 6664.2 6721.4 6794.5 6796.6 5785.7 6053.9 6122.1 6149.4 6740.5 5832.7 5995.7 6009.0 6010.3 6010.8 13421.9 13764.2 13772.8 13797.0 16807.8 2632.8 2633.5 2677.3 2691.2 2746.4 9615.8 9960.3 10417.3 10460.7 10551.1 1797.3 1834.4 1835.0 1844.1 1845.4 114549.0 117853.0 138547.3 144047.0 144293.6 11579.9 11795.8 12046.5 12170.6 12177.6 15365.6 15369.3 15643.0 15733.5 15775.8 8403.0 8655.8 8660.8 8794.8 8841.2 7249.9 8434.3 8607.2 8681.6 8774.3 4758.8 4768.1 4789.0 4796.7 4842.0 1578.9 1655.3 1659.0 1848.9 2002.5 974.8 1014.5 1021.7 1023.2 1082.3 19300.9 21428.5 21538.5 21550.0 21955.3 906.6 1034.8 1038.3 1081.9 1089.6 11106.9 11467.3 11489.4 11495.8 11510.1 589902.0 651682.0 701209.0 727353.0 728043.4 146314.0 149596.0 150590.0 152169.2 153275.0 1036.4 1063.5 1064.3 1082.5 1088.8 18583.8 19226.2 20075.5 20167.0 20180.7 54479.2 60740.7 61967.1 62581.4 62751.7 86325.0 87106.0 87213.0 88792.6 90216.5 8368.4 8379.2 8505.7 8580.3 8632.4 12178.6 13168.8 13234.3 13702.9 13719.9 9791.5 10845.0 11071.6 11099.5 11535.7 10474.0 11179.7 11223.4 11578.9 11595.4 11526.8 11798.8 11822.6 11993.5 12077.3 8187.0 8384.7 8469.5 8489.2 8523.9 8956.4 11305.3 11342.9 11517.8 11573.7 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5358.24 Median:5217.90 stddev:2913.00 (55.8%) stddev-sans-first:2906.26 08:48:55 INFO - PROCESS | 1639 | Values: 1436.2 1472.2 1473.3 1495.1 1500.6 7985.8 8393.7 8402.7 8411.2 8413.0 7407.8 7649.5 7928.2 8207.8 8248.7 2267.2 2313.4 2317.5 2320.1 2322.2 2310.7 2331.9 2337.2 2337.5 2348.7 2215.1 2260.0 2275.7 2299.3 2300.9 2250.6 2262.7 2267.1 2274.1 2274.7 2207.9 2298.1 2298.5 2299.5 2305.1 8308.4 8363.9 8367.4 8373.2 8375.2 5019.5 5067.2 5071.3 5184.9 5193.7 2947.8 3246.1 3325.6 3458.1 3497.0 1204.2 1211.6 1239.9 1252.1 1254.2 10183.5 10287.5 10291.5 10322.3 10335.9 4247.3 4259.3 4330.4 4338.1 4480.4 8318.3 9386.5 9403.3 9403.3 9424.2 4395.3 5211.3 5212.8 5217.7 5218.1 4269.9 4352.6 4683.8 4784.8 4789.8 3758.6 3782.8 3841.6 3873.9 3896.3 1244.3 1247.4 1252.3 1262.3 1263.1 860.8 869.3 874.4 909.0 917.7 4313.3 5286.9 5339.7 5473.5 5536.1 490.7 556.4 579.6 580.7 587.0 3656.5 3831.7 3852.9 3853.0 4109.0 9316.3 9685.7 9757.7 9862.6 9873.5 9550.4 9877.2 9889.6 9911.0 9921.9 7356.0 7578.6 7670.3 7738.5 7819.3 5613.0 5621.2 5717.7 5720.7 5881.4 8399.5 9056.8 9150.9 9266.0 9378.8 9150.5 9207.6 9328.6 9386.2 9453.0 6582.7 6797.0 6895.6 7056.9 7188.2 7755.2 7968.5 7974.4 7977.8 7978.9 6964.1 7159.5 7166.1 7216.0 7320.7 6980.0 6997.6 7006.3 7176.3 7217.9 6348.9 6382.6 6446.7 6446.8 6461.1 4944.6 4989.3 5007.6 5038.1 5064.1 4913.3 4979.4 4987.4 5051.3 5171.1 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4477.68 Median:4944.04 stddev:1372.14 (27.8%) stddev-sans-first:1340.60 08:48:55 INFO - PROCESS | 1639 | Values: 352.5 362.0 362.2 367.7 370.9 5247.2 5311.9 5330.9 5336.2 5347.5 5269.7 5320.5 5321.9 5349.9 5352.5 3461.8 3808.5 3909.5 3979.8 4099.7 4030.3 4122.2 4128.9 4139.4 4145.4 3600.6 3619.2 4009.4 4135.6 4192.5 3462.5 3929.3 3959.1 4103.4 4142.3 3473.8 3613.1 3637.0 3642.5 3678.3 5128.3 5128.4 5158.3 5204.5 5261.4 4275.4 4516.8 4692.2 4754.5 4801.6 5504.1 5514.5 5536.3 5545.3 5659.9 3549.7 3725.6 3986.0 4000.1 4027.3 5554.5 5836.1 5875.1 5900.0 5942.9 3819.4 3832.3 3845.8 3862.2 3872.2 3393.0 3745.4 3892.8 3927.4 3931.3 4257.6 4542.8 4547.0 4581.9 4584.5 4541.7 4777.9 5611.5 5650.4 5713.6 1153.4 1167.0 1229.3 1244.1 1285.4 822.9 856.7 868.7 875.9 878.9 4647.3 4865.3 4870.7 4894.5 4917.2 4896.4 4912.4 4981.5 5243.3 5418.6 3938.0 4382.8 4909.6 4921.4 4934.3 2427.6 2484.9 2513.9 2706.0 2869.1 4938.4 5281.5 5667.3 5675.0 5734.2 4735.4 5014.6 5315.8 5406.5 5410.6 4951.4 5868.2 5908.9 5947.9 5954.5 4949.7 5660.9 5707.4 5710.6 5778.7 4910.5 5357.3 5640.9 5749.7 5813.2 4884.0 5287.6 6076.8 6123.8 6142.4 3829.8 3910.2 3918.4 3942.5 3943.8 5451.5 5694.2 5724.8 5771.6 5788.7 4955.6 5240.3 5269.9 5652.9 5653.9 4156.6 4798.2 4965.4 5623.0 5626.7 5264.2 5306.3 5346.5 5379.3 5473.8 5077.9 5513.3 5588.8 5594.0 5597.9 4803.8 5191.7 5220.9 5428.4 5519.3 08:48:55 INFO - PROCESS | 1639 | 08:48:55 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21097.94 Median:5002.64 stddev:31058.18 (620.8%) stddev-sans-first:31107.60 08:48:55 INFO - PROCESS | 1639 | Values: 716.6 739.3 762.1 817.3 860.9 14747.6 15270.2 15558.7 15652.3 16020.6 14267.3 14468.7 14632.4 14859.4 14860.3 867.0 889.4 890.4 892.2 893.8 688.5 714.7 717.5 879.4 881.4 895.6 934.4 939.4 940.7 941.0 891.5 925.1 927.0 928.2 928.8 530.5 664.7 665.0 679.4 690.4 12362.7 14565.1 15104.8 15160.0 15360.6 14344.3 14354.6 14432.0 14509.3 14527.4 11914.1 11929.2 11999.4 12154.9 12157.6 3686.8 3715.8 3744.8 3756.1 3758.8 104489.0 106839.5 106906.9 107603.0 107683.0 11249.9 11304.4 11390.4 11486.3 11579.9 23903.2 23949.3 24177.4 24201.2 24438.4 7823.1 7828.6 7831.6 7853.6 8066.9 4206.3 4320.2 4334.9 4371.6 4488.3 3617.0 3725.9 3729.9 3733.7 3738.0 543.9 566.4 624.6 625.9 632.6 688.9 701.4 708.6 723.0 750.9 9749.8 10161.6 10183.2 10212.5 10544.6 614.8 639.2 643.4 647.2 648.2 4738.6 4992.4 5012.8 5032.1 5034.0 104887.0 107861.0 109687.0 109990.0 110392.0 76418.0 94937.6 95422.5 97974.5 99563.0 83047.6 83068.2 84448.0 84573.6 86057.0 9297.0 9461.3 9693.4 9704.8 9766.6 54242.7 54992.2 55274.0 56030.9 56121.7 71128.6 73973.0 75089.2 75271.6 76787.0 9919.0 9938.9 11725.9 12017.7 12383.1 12464.2 12816.0 12841.5 13062.3 13442.9 12005.4 12017.2 12020.2 12048.9 12072.3 11805.6 12000.9 12127.0 12228.5 12564.1 11834.9 11895.9 11962.8 12456.4 12458.3 8485.0 9644.5 9939.5 10135.4 10255.2 8489.8 9215.0 9741.4 9756.5 9837.1 08:48:55 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:48:55 INFO - PROCESS | 1639 | 08:48:56 INFO - TEST-INFO | 1639: exit 0 08:48:56 INFO - TEST-OK | dromaeo_css | took 1119322ms 08:48:56 INFO - TEST-START | kraken 08:48:56 INFO - operating with platform_type : mac_ 08:48:56 INFO - Initialising browser for kraken test... 08:48:56 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpQ_57In/profile http://localhost:49240/getInfo.html) 08:48:58 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:48:58 INFO - PROCESS | 1645 | colorDepth:24 08:48:58 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:48:58 INFO - PROCESS | 1645 | __metrics 08:48:58 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:48:58 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:59 INFO - TEST-INFO | 1645: exit 0 08:48:59 INFO - Browser initialized. 08:48:59 INFO - Running cycle 1/1 for kraken test... 08:48:59 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpQ_57In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:11 INFO - PROCESS | 1646 | RSS: Main: 234971136 08:49:11 INFO - PROCESS | 1646 | 08:49:13 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 08:49:14 INFO - PROCESS | 1646 | RSS: Main: 287023104 08:49:14 INFO - PROCESS | 1646 | 08:49:17 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 08:49:18 INFO - PROCESS | 1646 | RSS: Main: 287203328 08:49:18 INFO - PROCESS | 1646 | 08:49:21 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 08:49:21 INFO - PROCESS | 1646 | RSS: Main: 377278464 08:49:21 INFO - PROCESS | 1646 | 08:49:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 08:49:24 INFO - PROCESS | 1646 | RSS: Main: 280449024 08:49:24 INFO - PROCESS | 1646 | 08:49:26 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:49:27 INFO - PROCESS | 1646 | RSS: Main: 285253632 08:49:27 INFO - PROCESS | 1646 | 08:49:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 08:49:30 INFO - PROCESS | 1646 | RSS: Main: 327598080 08:49:30 INFO - PROCESS | 1646 | 08:49:33 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 08:49:34 INFO - PROCESS | 1646 | RSS: Main: 329637888 08:49:34 INFO - PROCESS | 1646 | 08:49:36 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 08:49:37 INFO - PROCESS | 1646 | RSS: Main: 327340032 08:49:37 INFO - PROCESS | 1646 | 08:49:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:39 INFO - PROCESS | 1646 | RSS: Main: 303505408 08:49:39 INFO - PROCESS | 1646 | 08:49:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:42 INFO - PROCESS | 1646 | RSS: Main: 305938432 08:49:42 INFO - PROCESS | 1646 | 08:49:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:45 INFO - PROCESS | 1646 | RSS: Main: 307228672 08:49:45 INFO - PROCESS | 1646 | 08:49:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:48 INFO - PROCESS | 1646 | RSS: Main: 320659456 08:49:48 INFO - PROCESS | 1646 | 08:49:52 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:52 INFO - PROCESS | 1646 | RSS: Main: 319668224 08:49:52 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 08:49:54 INFO - PROCESS | 1646 | RSS: Main: 363855872 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | __start_tp_report 08:49:54 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 08:49:54 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 08:49:54 INFO - PROCESS | 1646 | |i|pagename|runs| 08:49:54 INFO - PROCESS | 1646 | |0;ai-astar;115;112;113;113;113;115;112;113;113;113 08:49:54 INFO - PROCESS | 1646 | |1;audio-beat-detection;140;110;113;171;141;136;108;111;124;112 08:49:54 INFO - PROCESS | 1646 | |2;audio-dft;185;183;183;183;183;184;184;183;179;184 08:49:54 INFO - PROCESS | 1646 | |3;audio-fft;80;57;58;86;62;73;81;79;72;58 08:49:54 INFO - PROCESS | 1646 | |4;audio-oscillator;88;70;86;69;68;68;81;67;69;82 08:49:54 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;86;88;90;135;131;89;84;88;85 08:49:54 INFO - PROCESS | 1646 | |6;imaging-darkroom;93;94;94;94;94;94;93;94;93;111 08:49:54 INFO - PROCESS | 1646 | |7;imaging-desaturate;86;88;87;87;88;85;87;87;85;84 08:49:54 INFO - PROCESS | 1646 | |8;json-parse-financial;59;57;56;57;59;57;53;62;72;83 08:49:54 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;65;65;78;76;75;71;69;69;69;70 08:49:54 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;88;88;88;85;86;88;84;89;91;88 08:49:54 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;154;145;149;137;138;140;139;142;223;153 08:49:54 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;224;175;174;234;222;174;173;174;172;172 08:49:54 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;67;68;68;68;65;66;65;68;67;67 08:49:54 INFO - PROCESS | 1646 | __end_tp_report 08:49:54 INFO - PROCESS | 1646 | __start_cc_report 08:49:54 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1922 08:49:54 INFO - PROCESS | 1646 | __end_cc_report 08:49:54 INFO - PROCESS | 1646 | __startTimestamp1484844594613__endTimestamp 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | ------- Summary: start ------- 08:49:54 INFO - PROCESS | 1646 | Number of tests: 14 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 08:49:54 INFO - PROCESS | 1646 | Values: 115.0 112.0 113.0 113.0 113.0 115.0 112.0 113.0 113.0 113.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:130.00 stddev:20.32 (15.6%) stddev-sans-first:20.97 08:49:54 INFO - PROCESS | 1646 | Values: 140.0 110.0 113.0 171.0 141.0 136.0 108.0 111.0 124.0 112.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.60 (0.9%) stddev-sans-first:1.54 08:49:54 INFO - PROCESS | 1646 | Values: 185.0 183.0 183.0 183.0 183.0 184.0 184.0 183.0 179.0 184.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:70.60 Median:76.00 stddev:11.00 (14.5%) stddev-sans-first:11.13 08:49:54 INFO - PROCESS | 1646 | Values: 80.0 57.0 58.0 86.0 62.0 73.0 81.0 79.0 72.0 58.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.50 stddev:8.39 (11.1%) stddev-sans-first:7.42 08:49:54 INFO - PROCESS | 1646 | Values: 88.0 70.0 86.0 69.0 68.0 68.0 81.0 67.0 69.0 82.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:88.00 stddev:19.40 (22.0%) stddev-sans-first:20.33 08:49:54 INFO - PROCESS | 1646 | Values: 88.0 86.0 88.0 90.0 135.0 131.0 89.0 84.0 88.0 85.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:94.00 stddev:5.50 (5.9%) stddev-sans-first:5.77 08:49:54 INFO - PROCESS | 1646 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 111.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 08:49:54 INFO - PROCESS | 1646 | Values: 86.0 88.0 87.0 87.0 88.0 85.0 87.0 87.0 85.0 84.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:59.00 stddev:9.12 (15.5%) stddev-sans-first:9.63 08:49:54 INFO - PROCESS | 1646 | Values: 59.0 57.0 56.0 57.0 59.0 57.0 53.0 62.0 72.0 83.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:4.40 (6.2%) stddev-sans-first:4.15 08:49:54 INFO - PROCESS | 1646 | Values: 65.0 65.0 78.0 76.0 75.0 71.0 69.0 69.0 69.0 70.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:2.01 (2.3%) stddev-sans-first:2.13 08:49:54 INFO - PROCESS | 1646 | Values: 88.0 88.0 88.0 85.0 86.0 88.0 84.0 89.0 91.0 88.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:147.00 stddev:25.69 (17.5%) stddev-sans-first:27.23 08:49:54 INFO - PROCESS | 1646 | Values: 154.0 145.0 149.0 137.0 138.0 140.0 139.0 142.0 223.0 153.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:174.50 stddev:25.91 (14.8%) stddev-sans-first:24.27 08:49:54 INFO - PROCESS | 1646 | Values: 224.0 175.0 174.0 234.0 222.0 174.0 173.0 174.0 172.0 172.0 08:49:54 INFO - PROCESS | 1646 | 08:49:54 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.27 08:49:54 INFO - PROCESS | 1646 | Values: 67.0 68.0 68.0 68.0 65.0 66.0 65.0 68.0 67.0 67.0 08:49:54 INFO - PROCESS | 1646 | -------- Summary: end -------- 08:49:54 INFO - PROCESS | 1646 | 08:49:55 INFO - TEST-INFO | 1646: exit 0 08:49:55 INFO - TEST-OK | kraken | took 59504ms 08:49:55 INFO - SUITE-END | took 1178s 08:49:55 INFO - Completed test suite (00:19:39) 08:49:55 INFO - javascript benchmark 08:49:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.314493956269, 3276.164578032601, 3290.1445624137723, 3306.6442758469034, 3351.8156501392427, 5532.723363831812, 5575.330960284761, 5603.439656034395, 5608.495235428815, 5631.8028868989595, 5583.469570390816, 5621.887562248752, 5710.257666503348, 5719.799807006755, 5723.5135013523795, 5027.421846487664, 5088.491150884919, 5141.357330333708, 5159.71621560814, 5163.483651634844, 5202.219667049935, 5210.114280572293, 5218.582513398938, 5230.293910322096, 5257.316548848645, 5143.459936706667, 5164.45773193813, 5186.040582492251, 5199.6360254782185, 5202.739863006854, 5019.247112933089, 5065.164247899129, 5083.694978301313, 5095.668781529226, 5099.235114732783, 4200.7479551227025, 5083.949160508385, 5134.0758663440565, 5163.509466600704, 5183.81856635016, 5598.804041858515, 5600.243967064435, 5600.299962504687, 5605.663660180361, 5606.21512988182, 6024.126501657279, 6144.5698801083945, 6192.071189321593, 6194.94685903393, 6196.442320191204, 6130.080487926802, 6143.84640383994, 6160.353162917919, 6191.628502289877, 6206.6586337751405, 5737.995850726106, 5748.310202775652, 5751.827445176651, 5769.134629805562, 5787.218725472049, 5908.20239267702, 6283.0, 6325.746970121236, 6330.1454303668415, 6339.302676705559, 5938.198343223609, 5977.970110149508, 5978.85052873673, 6011.849703757353, 6016.398360164036, 6040.697965101727, 6083.695815209222, 6113.576218238259, 6187.16473276111, 6190.102435146879, 5987.850303742354, 5999.7900073498095, 6004.099385092271, 6008.759649613967, 6012.549058820606, 5220.399654039834, 6104.4200800923845, 6137.8187520601, 6195.473384762346, 6212.316645169119, 4879.1461494238365, 4891.364122664102, 4891.6575839691595, 4906.279520707957, 4913.852584422473, 4359.67302452311, 4376.737395756265, 4422.159789639958, 4423.314386270134, 4464.665150113755, 4706.317583950308, 5635.126555383922, 5635.718214089361, 5657.953278643382, 5664.2636457261115, 6237.064440333987, 6238.844028899314, 6251.812445626639, 6254.249490061131, 6256.124142620037, 5612.915806262909, 5617.269754931833, 5647.858803529944, 5679.545636349082, 5697.686627235459, 5163.199704045879, 5190.740462976912, 5205.089109405839, 5314.0700377433795, 5338.91991620126, 6293.937060629335, 6300.928842096946, 6303.432691057827, 6333.524985626004, 6335.493160547053, 6235.282942461675, 6247.031710084944, 6257.124002639725, 6258.718357673824, 6263.467605253604, 6234.470070043915, 6237.438630523275, 6278.968605156945, 6279.026750853625, 6287.993920972623, 6074.1799857020505, 6084.726187321493, 6086.6652334122045, 6147.44672979434, 6163.0, 6239.126522286792, 6248.187735594343, 6255.061740738925, 6262.68686565679, 6264.342244064308, 5975.462208401264, 5987.700614969147, 6032.638041717511, 6038.5772995889865, 6068.666223357581, 5853.678047707417, 5918.822435326947, 5956.880862382642, 5968.313643931004, 6003.429674180946, 5451.591130665295, 5876.1773351729935, 5880.088586269135, 5893.057110862242, 5893.823185304448, 5883.323417806836, 5947.137665038632, 5955.493783028318, 5998.550108741949, 6047.213862197887, 5754.136879467946, 5827.504662103769, 5829.5336373090895, 5830.650160990354, 5841.620294680833], "value": 5616.891163283272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.3238828998418, 501.36827597227494, 505.93675790526186, 509.1878453866082, 513.9511746384093, 40747.38878916815, 42120.57879421205, 42438.363424548654, 42642.360364594555, 44783.32825007627, 44094.11811763771, 44494.88762780932, 44503.77748111255, 44641.330380044325, 44732.55267447325, 8424.957875210615, 9325.766855828608, 9514.33399662024, 9517.23862091031, 9536.570854311538, 8441.535715535674, 9222.907770922271, 11371.772564548704, 11384.373859437728, 11541.596044138458, 11144.498497567589, 11170.93337732522, 11185.66443006707, 11195.4962026709, 11201.66395008151, 8435.198656127657, 8673.522956237404, 11349.0, 11441.59954401596, 11480.885191148065, 11018.0, 11327.037201837853, 11337.489812958436, 11523.42382880861, 11537.94231028848, 41781.79109104465, 42089.1582168358, 42090.789546052074, 42097.579024209976, 42172.57827421717, 4068.1456894052285, 4090.406891000788, 4106.856260030914, 4123.9175216495505, 4226.830926762926, 30074.39851202964, 30604.693953060407, 30703.385932281453, 30812.38375232505, 31440.842795786102, 3092.0667083842486, 3215.469447541176, 3246.2209069823307, 3253.186703324169, 3276.475763877792, 432762.0, 433443.0, 434231.0, 435168.0, 435190.0, 61560.0, 61909.690451548355, 61937.38062619406, 61945.070823937676, 62240.37759622437, 65187.34812651908, 65451.0, 65465.672671636334, 65572.67213663901, 65884.67057664681, 15552.989055711343, 16125.919370403073, 16126.145493268425, 16132.032078075354, 16145.273462693973, 11159.27464714791, 11472.94263528677, 11530.308181509135, 12404.875951240372, 12540.184887982434, 15910.443134490237, 16400.589985250463, 17321.65356692859, 17452.47642570725, 17499.475015749547, 7282.854342913112, 7298.671559779823, 7327.0841144856895, 7347.88978165328, 7349.30181632744, 886.5389997201419, 894.7986702991775, 898.5372533145435, 924.9861252081224, 941.1858742187958, 29990.850045750067, 30023.549646755317, 30182.698173018427, 30755.84883023404, 30816.229594259876, 1060.2525219720078, 1066.8879767624444, 1067.8718553773597, 1113.6158025481195, 1116.9891248420192, 15485.148316842457, 15486.5354039379, 15824.92087539555, 15919.442819501262, 16403.261853216634, 621993.0, 638175.0, 639017.0, 641006.0, 642439.0, 62131.0, 62659.0, 62704.0, 62767.0, 62913.68543157347, 1489.7690857917041, 1500.1149321900132, 1507.2765072765135, 1543.691261747655, 1549.1634517360724, 23186.95658695329, 25629.3592660185, 27598.4820834848, 28819.56770648484, 30094.69905300919, 54364.18453723118, 55074.0, 55211.723941380034, 55337.72331138318, 55361.16958245549, 447894.0, 482758.58620708075, 502404.0, 503109.0, 503477.0, 35848.235935226425, 41047.89521047872, 42074.36888446737, 42666.360004600574, 43077.56922430736, 44780.55219447894, 45353.092938141715, 45402.54597454115, 49199.0, 49385.753071234416, 35531.36716941114, 37043.88868333847, 37071.81464092662, 37751.0, 38267.808660956514, 35905.28189436145, 36017.459738103425, 36495.63504365028, 37369.6263037377, 37510.62489375071, 36277.637223627426, 36619.53521859096, 36968.26063478662, 37185.0, 37265.441018384205, 23772.881135594213, 26111.30660613501, 28135.296617584725, 28792.280192995342, 32924.835375823925, 23698.644520332553, 24094.51810963736, 24268.254340567804, 24528.01887924463, 24692.876535617208], "value": 20293.455713078834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1652091928105, 363.40945962810434, 390.8885967499265, 399.109984734043, 411.47947845974863, 16137.435189768346, 20652.48368790781, 21019.36941891742, 21144.8942755286, 21300.0, 21112.366629001117, 21646.567068658616, 21677.45806354842, 21840.890795546, 22104.778952210472, 5816.272965879265, 5893.145493903381, 6028.156058151862, 6101.481374083208, 6104.0, 4257.40396344512, 4445.0, 4448.110377924412, 5953.464188223059, 6071.453569178773, 6401.615903045832, 6664.233613134479, 6721.361470660304, 6794.524383293171, 6796.592204467748, 5785.710714464281, 6053.940560401956, 6122.081687746873, 6149.385061493815, 6740.460763138937, 5832.6500409975115, 5995.730192141364, 6009.0, 6010.338862725097, 6010.819675409744, 13421.86578134216, 13764.17414955106, 13772.793408098887, 13797.0, 16807.83192168087, 2632.8288661236957, 2633.5259653262406, 2677.290518012728, 2691.1926422073298, 2746.395792925553, 9615.806368004402, 9960.25298102638, 10417.27079104463, 10460.738481537946, 10551.050405463546, 1797.2541395320927, 1834.4038187588953, 1834.9816501834944, 1844.0687452836366, 1845.446366090181, 114549.0, 117852.99999999914, 138547.30726346406, 144047.0, 144293.55706442907, 11579.942100289612, 11795.764084718257, 12046.518139274505, 12170.57402990891, 12177.634670959886, 15365.6158596036, 15369.308381122877, 15642.983206091567, 15733.527994160193, 15775.842241577437, 8403.0, 8655.826883462421, 8660.78348041304, 8794.780130496662, 8841.16008979146, 7249.855002900018, 8434.287857329586, 8607.225349718556, 8681.56592170389, 8774.254188394058, 4758.762061896891, 4768.094062128184, 4789.0, 4796.664233503621, 4841.958978819571, 1578.873690104789, 1655.337864854068, 1659.029467761373, 1848.879822811513, 2002.5093852006353, 974.8050389922043, 1014.5434554450379, 1021.7241344836852, 1023.150784848574, 1082.3451811653836, 19300.90349548243, 21428.464288392603, 21538.492275572065, 21550.0, 21955.341339759834, 906.6146887572755, 1034.7826956339254, 1038.2680210451765, 1081.9459027048774, 1089.5968491658136, 11106.888931110747, 11467.254628449291, 11489.42552872353, 11495.770084598262, 11510.136739744552, 589902.0, 651682.0, 701209.0, 727353.0, 728043.3597831976, 146314.0, 149596.0, 150590.0, 152169.23915380353, 153275.0, 1036.4144258493927, 1063.5320458998017, 1064.297563608015, 1082.5182793656747, 1088.7985722641338, 18583.792053516478, 19226.230950761812, 20075.498112547302, 20167.0, 20180.697289540964, 54479.18281225706, 60740.69629651823, 61967.07049394353, 62581.374186257555, 62751.6862415685, 86325.0, 87106.0, 87213.0, 88792.5560372194, 90216.548917255, 8368.414211005414, 8379.162083791573, 8505.74482765518, 8580.270676992526, 8632.395732298679, 12178.57374991871, 13168.80246796318, 13234.272115033766, 13702.93148534251, 13719.862801371859, 9791.51042447889, 10845.0, 11071.612493562687, 11099.500522476346, 11535.653930382103, 10474.0, 11179.66461006171, 11223.438828058728, 11578.884211157781, 11595.362255075714, 11526.769464610494, 11798.764024719287, 11822.645320640395, 11993.460294286604, 12077.335746533674, 8186.959065204635, 8384.706535271236, 8469.534175620154, 8489.193526614961, 8523.91476085256, 8956.417832840845, 11305.26515776472, 11342.886571134182, 11517.827232591686, 11573.710657233636], "value": 9847.670278901187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.2172615924321, 1472.1755816742625, 1473.3222717549927, 1495.0805254768318, 1500.5648361975027, 7985.760427187186, 8393.748187554376, 8402.705905293316, 8411.242988131067, 8413.0, 7407.814804629874, 7649.502782319159, 7928.246816552432, 8207.83584328313, 8248.711295104673, 2267.1951457232735, 2313.3869524576003, 2317.5249073939885, 2320.1299512682745, 2322.1872344679314, 2310.745817960023, 2331.94170145746, 2337.1586228957563, 2337.4740683346195, 2348.7064116985375, 2215.080741492279, 2259.9886101369793, 2275.6927814744963, 2299.287220961499, 2300.8734519601417, 2250.6173950428465, 2262.7058482397347, 2267.1498188179517, 2274.0789980058103, 2274.6815445837597, 2207.9006444710026, 2298.138198175684, 2298.5402919416183, 2299.471121642015, 2305.0549274797254, 8308.418410711252, 8363.916360836374, 8367.372447066495, 8373.204545568162, 8375.246227839463, 5019.498050194988, 5067.239914012891, 5071.29001939725, 5184.870378240536, 5193.68837869729, 2947.82313061217, 3246.1397729601676, 3325.551050608161, 3458.066322093046, 3497.0383144635175, 1204.2172587817902, 1211.5517258614282, 1239.876012398762, 1252.0797214047668, 1254.1910467748341, 10183.490825458697, 10287.485625718758, 10291.53688084038, 10322.329048611891, 10335.94832025835, 4247.299195632686, 4259.297215959394, 4330.39374487572, 4338.110687309158, 4480.350349199413, 8318.251357377743, 9386.48374339418, 9403.294752893424, 9403.29475289356, 9424.151826335663, 4395.318725597537, 5211.322528071327, 5212.817551385683, 5217.686938783685, 5218.112920803473, 4269.914601707948, 4352.586504282088, 4683.7892294846815, 4784.808607655655, 4789.760511974388, 3758.567764707039, 3782.7541209821275, 3841.615838416136, 3873.8837834865, 3896.337622604164, 1244.3031902134833, 1247.4324182496941, 1252.292454763056, 1262.299423819789, 1263.1347526944073, 860.7848037990502, 869.3306154261184, 874.4316194473643, 908.955298095567, 917.7430319510547, 4313.309870420718, 5286.867828304323, 5339.706316152571, 5473.452654734495, 5536.114221724505, 490.73500309833, 556.4491153757832, 579.6174524813687, 580.7067430947344, 586.9706514674249, 3656.5246517952496, 3831.674307683878, 3852.903677408031, 3852.998220462644, 4109.0, 9316.254699624014, 9685.661001865043, 9757.658481953098, 9862.605495780232, 9873.456959867133, 9550.37922535033, 9877.160441362565, 9889.60441582343, 9911.0, 9921.851172232422, 7355.963220183865, 7578.583177925157, 7670.309672129423, 7738.496997695244, 7819.257170568787, 5613.0, 5621.184928185472, 5717.742701578356, 5720.656760594211, 5881.353051164283, 8399.496030238206, 9056.818863622559, 9150.908490915006, 9266.0, 9378.76553086151, 9150.49672268005, 9207.585658645243, 9328.580213890527, 9386.15524602789, 9453.0, 6582.736690532325, 6797.0, 6895.620740859301, 7056.8588628226125, 7188.209296977224, 7755.185705501067, 7968.482048666818, 7974.40191985615, 7977.760667179994, 7978.920210797818, 6964.050442311303, 7159.534630249017, 7166.140063192451, 7215.963920180366, 7320.707171713285, 6979.965100174467, 6997.615131167631, 7006.334398232159, 7176.282371762782, 7217.927820721726, 6348.873022539616, 6382.553221274652, 6446.7098980546925, 6446.774362897276, 6461.127747754181, 4944.604431645532, 4989.25161225819, 5007.57435617962, 5038.067957427887, 5064.088464076502, 4913.336699545515, 4979.4024717032735, 4987.426445958616, 5051.3433253676785, 5171.095058364846], "value": 4319.76132868259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.52057202205, 361.9891403257902, 362.1597892888499, 367.6617511889062, 370.9035650730809, 5247.212918062292, 5311.875249900032, 5330.920036199455, 5336.172893201555, 5347.518723314901, 5269.710165940872, 5320.521153096221, 5321.893562128765, 5349.9300139972065, 5352.5182733553975, 3461.7749846259912, 3808.5239345081864, 3909.511311086107, 3979.7814316824115, 4099.6720262379085, 4030.274550580909, 4122.237386083569, 4128.903322508119, 4139.3856396005585, 4145.440365550658, 3600.6399360064047, 3619.2037751694584, 4009.3785463253244, 4135.648469880049, 4192.538820729717, 3462.515247865301, 3929.2534418460546, 3959.1289916218384, 4103.363978583325, 4142.337226043818, 3473.774204676713, 3613.0606042428894, 3637.0, 3642.526471558707, 3678.301122786662, 5128.281995553231, 5128.435872054071, 5158.303629010074, 5204.531592156724, 5261.447548007481, 4275.444192254987, 4516.7578915798085, 4692.178868697964, 4754.548317909793, 4801.591864691505, 5504.137848318892, 5514.531264842453, 5536.252605898192, 5545.251391062236, 5659.886802263932, 3549.6627820357025, 3725.5529336479794, 3985.9507476780286, 4000.079981604247, 4027.3153563894207, 5554.527865131468, 5836.095405212199, 5875.059990401515, 5899.970500147515, 5942.940570594325, 3819.4270859370763, 3832.329342365075, 3845.8461661533224, 3862.24686186191, 3872.186840763471, 3393.0499460151195, 3745.4418302612626, 3892.766434013968, 3927.430522574211, 3931.331673615492, 4257.616814486649, 4542.750148741851, 4546.953541127453, 4581.908361832745, 4584.472785629629, 4541.683741291965, 4777.928331075037, 5611.494965453129, 5650.378458369576, 5713.628614140068, 1153.3541216918552, 1166.988330116705, 1229.305442425027, 1244.0545185658964, 1285.395863943945, 822.9466283157568, 856.7491462464747, 868.6699054359303, 875.8773771671971, 878.9077146899612, 4647.256438969748, 4865.270209468608, 4870.707757534559, 4894.531640507905, 4917.237828136645, 4896.436909755424, 4912.361393018885, 4981.452040275567, 5243.344581927259, 5418.647787893774, 3937.9803100984313, 4382.780860956939, 4909.558139767367, 4921.3602231710365, 4934.309196712463, 2427.5994460913753, 2484.90664107792, 2513.9371515712255, 2705.971730742305, 2869.110575721533, 4938.357978481496, 5281.498257665516, 5667.291588551431, 5675.0, 5734.168545560954, 4735.360726301974, 5014.598832093497, 5315.840524784263, 5406.54044406222, 5410.594205434608, 4951.356323677899, 5868.212599015605, 5908.911366329508, 5947.940520594739, 5954.541137421359, 4949.727764972961, 5660.914801433147, 5707.400722924199, 5710.571707122065, 5778.682172480554, 4910.459849416633, 5357.330333708286, 5640.943590564042, 5749.655020698771, 5813.157092221689, 4884.0, 5287.629865909349, 6076.817695469143, 6123.84690382744, 6142.358785722183, 3829.789361585028, 3910.1788624389196, 3918.4318273850704, 3942.546607140101, 3943.8422463101156, 5451.454854514517, 5694.202811606296, 5724.771009159587, 5771.59598828078, 5788.652680839163, 4955.603551715926, 5240.2663627093, 5269.920951185812, 5652.943470565242, 5653.858653533694, 4156.646685031807, 4798.23228283473, 4965.4289756678445, 5623.0, 5626.662400255997, 5264.236480778829, 5306.310179676618, 5346.518813306821, 5379.273798037215, 5473.768402109494, 5077.949220507895, 5513.283273174462, 5588.804391846266, 5594.0, 5597.888042239214, 4803.831865884677, 5191.714455704972, 5220.869478263074, 5428.430014848384, 5519.337679478488], "value": 4050.3751969701025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.5664772812445, 739.2828955912767, 762.051246198483, 817.337956255433, 860.948343099414, 14747.631309217262, 15270.16014119223, 15558.688826223468, 15652.295646695897, 16020.59948501288, 14267.286635668226, 14468.710625787478, 14632.41470341185, 14859.405623775036, 14860.256987150626, 866.960986755596, 889.4440974391006, 890.3945317184312, 892.1970226795871, 893.7676204186894, 688.490517017406, 714.7033980897921, 717.4511498703496, 879.3888247667874, 881.3918396306528, 895.6327905558722, 934.4019827310527, 939.4316438554679, 940.6613619097119, 941.016637613692, 891.4829398948594, 925.0934084597098, 926.9953650231773, 928.215657769184, 928.7724507495707, 530.5490333216774, 664.6510581944469, 665.0058163046228, 679.3953381490477, 690.378659206713, 12362.690932726664, 14565.126092434488, 15104.773428398583, 15160.014599051026, 15360.615984600363, 14344.282785860665, 14354.64113397163, 14432.0, 14509.347079381454, 14527.418903243857, 11914.106442016884, 11929.164958452911, 11999.400029998465, 12154.939225303906, 12157.574484893075, 3686.8340924658455, 3715.758475699071, 3744.7753134811996, 3756.0609847538117, 3758.830852611639, 104489.0, 106839.46580267049, 106906.93093069048, 107603.0, 107683.0, 11249.94375028136, 11304.434778261055, 11390.37352945596, 11486.310821350746, 11579.88420115805, 23903.163389281293, 23949.28152155438, 24177.395565111012, 24201.152959646326, 24438.389040274134, 7823.061232652118, 7828.647710852912, 7831.569263690438, 7853.646585903648, 8066.919330806617, 4206.305959516707, 4320.222359975234, 4334.913301734011, 4371.628411584988, 4488.259437192892, 3616.9819150904077, 3725.869594564177, 3729.850805967731, 3733.701303895682, 3737.981310093432, 543.9075357189288, 566.4250785452768, 624.569047357322, 625.8873402787542, 632.5603705424686, 688.896665500169, 701.3792793377897, 708.6208878250111, 722.9746958856415, 750.8535835512023, 9749.805003899883, 10161.644342447978, 10183.236257280734, 10212.489375531342, 10544.630937917136, 614.757170917485, 639.1946147853738, 643.4144928115393, 647.2039391548328, 648.2091847945499, 4738.573528382393, 4992.425871024879, 5012.8496145115705, 5032.094223039815, 5033.974830125826, 104887.0, 107861.0, 109687.0, 109990.0, 110392.0, 76418.0, 94937.55419777427, 95422.52288738512, 97974.51012744891, 99563.00436995682, 83047.58476207701, 83068.16931830604, 84448.0, 84573.57713211395, 86057.0, 9296.95351523238, 9461.290403219647, 9693.352234574293, 9704.805903882025, 9766.60933562678, 54242.728786355816, 54992.17511737247, 55274.0, 56030.90284891924, 56121.71939140278, 71128.64435677789, 73973.0, 75089.24910750822, 75271.62364188144, 76787.0, 9918.950405247928, 9938.938281918092, 11725.941370293094, 12017.699557511132, 12383.133180677267, 12464.189827661174, 12816.0, 12841.486340546273, 13062.281574513492, 13442.93278533601, 12005.39973001364, 12017.218880772722, 12020.218685785396, 12048.879511204776, 12072.275663460221, 11805.586804461802, 12000.879991199976, 12127.0, 12228.510859565518, 12564.057695672678, 11834.940825296162, 11895.940520297343, 11962.76074478523, 12456.377181141088, 12458.31479268649, 8485.0, 9644.469554174588, 9939.503024848873, 10135.442550659785, 10255.159194443813, 8489.791858354165, 9215.0, 9741.366811157252, 9756.46339451337, 9837.114659680663], "value": 7455.226627517587, "unit": "score"}], "name": "dromaeo_css", "value": 7260.0879120828995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 113.0, 113.0, 113.0, 115.0, 112.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 113.0, 171.0, 141.0, 136.0, 108.0, 111.0, 124.0, 112.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 183.0, 183.0, 184.0, 184.0, 183.0, 179.0, 184.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 86.0, 62.0, 73.0, 81.0, 79.0, 72.0, 58.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 86.0, 69.0, 68.0, 68.0, 81.0, 67.0, 69.0, 82.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 90.0, 135.0, 131.0, 89.0, 84.0, 88.0, 85.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 111.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 87.0, 87.0, 88.0, 85.0, 87.0, 87.0, 85.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 56.0, 57.0, 59.0, 57.0, 53.0, 62.0, 72.0, 83.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 78.0, 76.0, 75.0, 71.0, 69.0, 69.0, 69.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 85.0, 86.0, 88.0, 84.0, 89.0, 91.0, 88.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 145.0, 149.0, 137.0, 138.0, 140.0, 139.0, 142.0, 223.0, 153.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 175.0, 174.0, 234.0, 222.0, 174.0, 173.0, 174.0, 172.0, 172.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 65.0, 66.0, 65.0, 68.0, 67.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1474.5, "alertThreshold": 2.0}]} 08:49:55 INFO - Return code: 0 08:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:49:55 ERROR - # TBPL SUCCESS # 08:49:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:55 INFO - 2017-01-19 08:49:55.919 screenresolution[1650:9648] starting screenresolution argv=screenresolution get 08:49:55 INFO - 2017-01-19 08:49:55.922 screenresolution[1650:9648] Display 0: 1600x1200x32@60 08:49:55 INFO - 2017-01-19 08:49:55.928 screenresolution[1651:9651] starting screenresolution argv=screenresolution list 08:49:55 INFO - Available Modes on Display 0 08:49:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:56 INFO - Intel Iris: 08:49:56 INFO - Chipset Model: Intel Iris 08:49:56 INFO - Type: GPU 08:49:56 INFO - Bus: Built-In 08:49:56 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:56 INFO - Vendor: Intel (0x8086) 08:49:56 INFO - Device ID: 0x0a2e 08:49:56 INFO - Revision ID: 0x0009 08:49:56 INFO - Displays: 08:49:56 INFO - Display: 08:49:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:56 INFO - Display Serial Number: 1600x1200 60 08:49:56 INFO - Main Display: Yes 08:49:56 INFO - Mirror: Off 08:49:56 INFO - Online: Yes 08:49:56 INFO - Rotation: Supported 08:49:56 INFO - Return code: 0 08:49:56 INFO - Running post-action listener: _resource_record_post_action 08:49:56 INFO - [mozharness: 2017-01-19 16:49:56.163136Z] Finished run-tests step (success) 08:49:56 INFO - Running post-run listener: _resource_record_post_run 08:49:56 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37745664; Write bytes: 550121472; Read time: 232; Write time: 1638 08:49:56 INFO - TinderboxPrint: CPU usage
53.7% 08:49:56 INFO - TinderboxPrint: I/O read bytes / time
37,745,664 / 232 08:49:56 INFO - TinderboxPrint: I/O write bytes / time
550,121,472 / 1,638 08:49:56 INFO - TinderboxPrint: CPU idle
2,228.5 (46.3%) 08:49:56 INFO - TinderboxPrint: CPU system
960.0 (20.0%) 08:49:56 INFO - TinderboxPrint: CPU user
1,621.2 (33.7%) 08:49:56 INFO - TinderboxPrint: Swap in / out
288,350,208 / 0 08:49:56 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 248209920; Write bytes: 237393920; Read time: 17860; Write time: 517 08:49:56 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30440448; Write bytes: 295225344; Read time: 174; Write time: 1074 08:49:56 INFO - Running post-run listener: _upload_blobber_files 08:49:56 INFO - Blob upload gear active. 08:49:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:49:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:49:57 INFO - (blobuploader) - INFO - Open directory for files ... 08:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:58 INFO - (blobuploader) - INFO - Done attempting. 08:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:59 INFO - (blobuploader) - INFO - Done attempting. 08:49:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:49:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:00 INFO - (blobuploader) - INFO - Done attempting. 08:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:50:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:50:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:50:04 INFO - (blobuploader) - INFO - Done attempting. 08:50:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:50:04 INFO - Return code: 0 08:50:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:50:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:50:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa62f2713ae63018bb71e273d398f5a264d199fa6707ae56734205c971d8b2e4acbc1cbb09fbe2240823ca04d726dc95c9c0ce3e52e159b51290a61df5b7588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176e3a885fd057b38130f6a5faf38e8cad04e6f66577912f4230491b1e904e5671bbe9220dfd58d0c484ce0f4bd4cc104318cbf45ce9947e90b865a96d951c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d220b874eb1d990256e9c5445429165e50af2b3754f3c631ab0c944d2fb32a1c8448f211a693fba6fecccb99ea0220d8d654f2ef234e1b967e37b54e68e56f44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65f5063ba24d3c5ad1ccd97f90b737bc3d4f6f845278634d980ae1fd0d238fbd76b8ef5cd1163b4c7753c5d2d88afe66896fdc0f337a70daed65c0809cdaf03e"} 08:50:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:50:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:50:04 INFO - Contents: 08:50:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa62f2713ae63018bb71e273d398f5a264d199fa6707ae56734205c971d8b2e4acbc1cbb09fbe2240823ca04d726dc95c9c0ce3e52e159b51290a61df5b7588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176e3a885fd057b38130f6a5faf38e8cad04e6f66577912f4230491b1e904e5671bbe9220dfd58d0c484ce0f4bd4cc104318cbf45ce9947e90b865a96d951c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d220b874eb1d990256e9c5445429165e50af2b3754f3c631ab0c944d2fb32a1c8448f211a693fba6fecccb99ea0220d8d654f2ef234e1b967e37b54e68e56f44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65f5063ba24d3c5ad1ccd97f90b737bc3d4f6f845278634d980ae1fd0d238fbd76b8ef5cd1163b4c7753c5d2d88afe66896fdc0f337a70daed65c0809cdaf03e"} 08:50:04 INFO - Running post-run listener: copy_logs_to_upload_dir 08:50:04 INFO - Copying logs to upload dir... 08:50:04 INFO - mkdir: /builds/slave/test/build/upload/logs 08:50:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.783210 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-19 08:50:04.530385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 08:50:04.535017) ========= 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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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/8fa62f2713ae63018bb71e273d398f5a264d199fa6707ae56734205c971d8b2e4acbc1cbb09fbe2240823ca04d726dc95c9c0ce3e52e159b51290a61df5b7588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176e3a885fd057b38130f6a5faf38e8cad04e6f66577912f4230491b1e904e5671bbe9220dfd58d0c484ce0f4bd4cc104318cbf45ce9947e90b865a96d951c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d220b874eb1d990256e9c5445429165e50af2b3754f3c631ab0c944d2fb32a1c8448f211a693fba6fecccb99ea0220d8d654f2ef234e1b967e37b54e68e56f44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65f5063ba24d3c5ad1ccd97f90b737bc3d4f6f845278634d980ae1fd0d238fbd76b8ef5cd1163b4c7753c5d2d88afe66896fdc0f337a70daed65c0809cdaf03e"} build_url:https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/I5vM5wREQx6CvNpKF5tLdg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa62f2713ae63018bb71e273d398f5a264d199fa6707ae56734205c971d8b2e4acbc1cbb09fbe2240823ca04d726dc95c9c0ce3e52e159b51290a61df5b7588", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/176e3a885fd057b38130f6a5faf38e8cad04e6f66577912f4230491b1e904e5671bbe9220dfd58d0c484ce0f4bd4cc104318cbf45ce9947e90b865a96d951c75", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d220b874eb1d990256e9c5445429165e50af2b3754f3c631ab0c944d2fb32a1c8448f211a693fba6fecccb99ea0220d8d654f2ef234e1b967e37b54e68e56f44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65f5063ba24d3c5ad1ccd97f90b737bc3d4f6f845278634d980ae1fd0d238fbd76b8ef5cd1163b4c7753c5d2d88afe66896fdc0f337a70daed65c0809cdaf03e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 08:50:04.574577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:50:04.574911) ========= 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.qgAx2fe5J7/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.ibgrSvBX1E/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.005386 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 08:50:04.623428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 08:50:04.624126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 08:50:04.624455) ========= ========= Total master_lag: 0.30 =========