builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0256 starttime: 1490881557.42 results: success (0) buildid: 20170330060421 builduid: 93aac18708fb408aac39764995669c49 revision: fa249f1c67934d6d3bdb4048bf43d313412507bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:57.420294) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:57.420794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:57.421197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:57.449783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:57.450309) ========= 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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-03-30 06:45:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2017-03-30 06:45:58 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.622158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:58.094116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:58.094456) ========= 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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.026433 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:58.143082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 06:45:58.144400) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fa249f1c67934d6d3bdb4048bf43d313412507bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fa249f1c67934d6d3bdb4048bf43d313412507bc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-03-30 06:45:58,770 truncating revision to first 12 chars 2017-03-30 06:45:58,770 Setting DEBUG logging. 2017-03-30 06:45:58,770 attempt 1/10 2017-03-30 06:45:58,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fa249f1c6793?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 06:45:59,731 unpacking tar archive at: mozilla-aurora-fa249f1c6793/testing/mozharness/ program finished with exit code 0 elapsedTime=1.248083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 06:45:59.416373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:59.416702) ========= script_repo_revision: fa249f1c67934d6d3bdb4048bf43d313412507bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:59.417104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:59.417401) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 06:45:59.437311) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-30 06:45:59.437718) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:00 INFO - MultiFileLogger online at 20170330 06:46:00 in /builds/slave/test 06:46:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:46:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:46:00 INFO - {'append_to_log': False, 06:46:00 INFO - 'base_work_dir': '/builds/slave/test', 06:46:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:46:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:46:00 INFO - 'branch': 'Mozilla-Aurora', 06:46:00 INFO - 'buildbot_json_path': 'buildprops.json', 06:46:00 INFO - 'config_files': ('talos/mac_config.py',), 06:46:00 INFO - 'default_actions': ('clobber', 06:46:00 INFO - 'read-buildbot-config', 06:46:00 INFO - 'download-and-extract', 06:46:00 INFO - 'populate-webroot', 06:46:00 INFO - 'create-virtualenv', 06:46:00 INFO - 'install', 06:46:00 INFO - 'run-tests'), 06:46:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:46:00 INFO - 'download_minidump_stackwalk': True, 06:46:00 INFO - 'download_symbols': 'ondemand', 06:46:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:46:00 INFO - 'tooltool.py': '/tools/tooltool.py', 06:46:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:46:00 INFO - '/tools/misc-python/virtualenv.py')}, 06:46:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:46:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:46:00 INFO - 'gecko_profile': False, 06:46:00 INFO - 'gecko_profile_interval': 0, 06:46:00 INFO - 'installer_path': 'installer.exe', 06:46:00 INFO - 'log_level': 'info', 06:46:00 INFO - 'log_name': 'talos', 06:46:00 INFO - 'log_to_console': True, 06:46:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:46:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:46:00 INFO - 'opt_config_files': (), 06:46:00 INFO - 'pip_index': False, 06:46:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:46:00 INFO - 'cmd': ('bash', 06:46:00 INFO - '-c', 06:46:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:46:00 INFO - 'enabled': True, 06:46:00 INFO - 'halt_on_failure': False, 06:46:00 INFO - 'name': 'check_screen_resolution'},), 06:46:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:46:00 INFO - 'cmd': ('bash', 06:46:00 INFO - '-c', 06:46:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:46:00 INFO - 'enabled': True, 06:46:00 INFO - 'halt_on_failure': False, 06:46:00 INFO - 'name': 'check_screen_resolution'},), 06:46:00 INFO - 'run_cmd_checks_enabled': True, 06:46:00 INFO - 'suite': 'dromaeojs', 06:46:00 INFO - 'system_bits': '32', 06:46:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:46:00 INFO - 'title': 't-yosemite-r7-0256', 06:46:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:46:00 INFO - 'use_talos_json': True, 06:46:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:46:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:46:00 INFO - 'work_dir': 'build'} 06:46:00 INFO - [mozharness: 2017-03-30 13:46:00.174788Z] Running clobber step. 06:46:00 INFO - Running pre-action listener: _resource_record_pre_action 06:46:00 INFO - Running main action method: clobber 06:46:00 INFO - rmtree: /builds/slave/test/build 06:46:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:46:02 INFO - Running post-action listener: _resource_record_post_action 06:46:02 INFO - [mozharness: 2017-03-30 13:46:02.724737Z] Finished clobber step (success) 06:46:02 INFO - [mozharness: 2017-03-30 13:46:02.724861Z] Running read-buildbot-config step. 06:46:02 INFO - Running pre-action listener: _resource_record_pre_action 06:46:02 INFO - Running main action method: read_buildbot_config 06:46:02 INFO - Using buildbot properties: 06:46:02 INFO - { 06:46:02 INFO - "project": "", 06:46:02 INFO - "product": "firefox", 06:46:02 INFO - "script_repo_revision": "production", 06:46:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:46:02 INFO - "repository": "", 06:46:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:46:02 INFO - "buildid": "20170330060421", 06:46:02 INFO - "pgo_build": "False", 06:46:02 INFO - "basedir": "/builds/slave/test", 06:46:02 INFO - "buildnumber": 75, 06:46:02 INFO - "slavename": "t-yosemite-r7-0256", 06:46:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:46:02 INFO - "platform": "yosemite_r7", 06:46:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:46:02 INFO - "branch": "mozilla-aurora", 06:46:02 INFO - "repo_path": "releases/mozilla-aurora", 06:46:02 INFO - "revision": "fa249f1c67934d6d3bdb4048bf43d313412507bc", 06:46:02 INFO - "stage_platform": "macosx64", 06:46:02 INFO - "builduid": "93aac18708fb408aac39764995669c49", 06:46:02 INFO - "slavebuilddir": "test" 06:46:02 INFO - } 06:46:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 06:46:02 INFO - Running post-action listener: _resource_record_post_action 06:46:02 INFO - [mozharness: 2017-03-30 13:46:02.728224Z] Finished read-buildbot-config step (success) 06:46:02 INFO - [mozharness: 2017-03-30 13:46:02.728363Z] Running download-and-extract step. 06:46:02 INFO - Running pre-action listener: _resource_record_pre_action 06:46:02 INFO - Running main action method: download_and_extract 06:46:02 INFO - mkdir: /builds/slave/test/build/tests 06:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:02 INFO - trying https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 06:46:02 INFO - Downloading https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 06:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 06:46:04 INFO - Downloaded 1199 bytes. 06:46:04 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 06:46:04 INFO - Using the following test package requirements: 06:46:04 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 06:46:04 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 06:46:04 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 06:46:04 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'jsshell-mac.zip'], 06:46:04 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 06:46:04 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 06:46:04 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 06:46:04 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 06:46:04 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 06:46:04 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 06:46:04 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 06:46:04 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:46:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 06:46:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:46:04 INFO - Fetch https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 06:46:05 INFO - Expected file size: 51791545 06:46:05 INFO - Obtained file size: 51791545 06:46:21 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:46:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 06:46:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:46:21 INFO - Fetch https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 06:46:22 INFO - Expected file size: 51791545 06:46:22 INFO - Obtained file size: 51791545 06:46:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 06:46:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:46:37 INFO - Fetch https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 06:46:39 INFO - Expected file size: 14404438 06:46:39 INFO - Obtained file size: 14404438 06:46:39 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')]} 06:46:39 INFO - trying https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 06:46:39 INFO - Downloading https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 06:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 06:46:42 INFO - Downloaded 74686667 bytes. 06:46:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 06:46:42 INFO - mkdir: /builds/slave/test/properties 06:46:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:46:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:46:42 INFO - Contents: 06:46:42 INFO - build_url:https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 06:46:42 INFO - Running post-action listener: _resource_record_post_action 06:46:42 INFO - Running post-action listener: set_extra_try_arguments 06:46:42 INFO - [mozharness: 2017-03-30 13:46:42.993526Z] Finished download-and-extract step (success) 06:46:42 INFO - [mozharness: 2017-03-30 13:46:42.993690Z] Running populate-webroot step. 06:46:42 INFO - Running pre-action listener: _resource_record_pre_action 06:46:42 INFO - Running main action method: populate_webroot 06:46:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:46:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:46:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:46:43 INFO - '--tppagecycles', 06:46:43 INFO - '7'], 06:46:43 INFO - 'tests': ['tsvgm']}}, 06:46:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:46:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:46:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:46:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:46:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['damp', 'tps']}, 06:46:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'tests': ['damp', 'tps']}, 06:46:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['dromaeo_dom']}, 06:46:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:46:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['basic_compositor_video']}, 06:46:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:46:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['a11yr', 06:46:43 INFO - 'ts_paint', 06:46:43 INFO - 'tpaint', 06:46:43 INFO - 'sessionrestore', 06:46:43 INFO - 'sessionrestore_no_auto_restore', 06:46:43 INFO - 'tabpaint']}, 06:46:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:46:43 INFO - 'ts_paint', 06:46:43 INFO - 'tpaint', 06:46:43 INFO - 'sessionrestore', 06:46:43 INFO - 'sessionrestore_no_auto_restore', 06:46:43 INFO - 'tabpaint']}, 06:46:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:46:43 INFO - 'ts_paint', 06:46:43 INFO - 'tpaint', 06:46:43 INFO - 'sessionrestore', 06:46:43 INFO - 'sessionrestore_no_auto_restore', 06:46:43 INFO - 'tabpaint']}, 06:46:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:46:43 INFO - 'ts_paint', 06:46:43 INFO - 'tpaint', 06:46:43 INFO - 'sessionrestore', 06:46:43 INFO - 'sessionrestore_no_auto_restore', 06:46:43 INFO - 'tabpaint']}, 06:46:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['a11yr', 06:46:43 INFO - 'ts_paint', 06:46:43 INFO - 'tpaint', 06:46:43 INFO - 'sessionrestore', 06:46:43 INFO - 'sessionrestore_no_auto_restore', 06:46:43 INFO - 'tabpaint']}, 06:46:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['a11yr', 06:46:43 INFO - 'ts_paint', 06:46:43 INFO - 'tpaint', 06:46:43 INFO - 'sessionrestore', 06:46:43 INFO - 'sessionrestore_no_auto_restore', 06:46:43 INFO - 'tabpaint']}, 06:46:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['tsvgx', 06:46:43 INFO - 'tsvgr_opacity', 06:46:43 INFO - 'tart', 06:46:43 INFO - 'tscrollx', 06:46:43 INFO - 'cart', 06:46:43 INFO - 'tsvg_static']}, 06:46:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:46:43 INFO - 'tsvgr_opacity', 06:46:43 INFO - 'tart', 06:46:43 INFO - 'tscrollx', 06:46:43 INFO - 'cart', 06:46:43 INFO - 'tsvg_static']}, 06:46:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'talos_options': ['--disable-e10s'], 06:46:43 INFO - 'tests': ['tp5o']}, 06:46:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:46:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'talos_options': ['--disable-e10s', 06:46:43 INFO - '--xperf_path', 06:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:43 INFO - 'tests': ['tp5n']}, 06:46:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:46:43 INFO - 'talos_options': ['--xperf_path', 06:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:43 INFO - 'tests': ['tp5n']}}, 06:46:43 INFO - 'talos.zip': {'path': '', 06:46:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:46:43 INFO - Running post-action listener: _resource_record_post_action 06:46:43 INFO - [mozharness: 2017-03-30 13:46:43.012237Z] Finished populate-webroot step (success) 06:46:43 INFO - [mozharness: 2017-03-30 13:46:43.012343Z] Running create-virtualenv step. 06:46:43 INFO - Running pre-action listener: _resource_record_pre_action 06:46:43 INFO - Running main action method: create_virtualenv 06:46:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:46:43 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 06:46:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:46:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:46:43 INFO - Using real prefix '/tools/python27' 06:46:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:46:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:46:46 INFO - Installing pip.................done. 06:46:46 INFO - Return code: 0 06:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:46:46 INFO - Reading from file tmpfile_stdout 06:46:46 INFO - Output received: 06:46:46 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) 06:46:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:46:46 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')]} 06:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:46 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')]} 06:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:46 INFO - 'HOME': '/Users/cltbld', 06:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:46 INFO - 'LOGNAME': 'cltbld', 06:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:46 INFO - 'MOZ_NO_REMOTE': '1', 06:46:46 INFO - 'NO_EM_RESTART': '1', 06:46:46 INFO - 'PAGER': '/bin/cat', 06:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:46 INFO - 'PWD': '/builds/slave/test', 06:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:46 INFO - 'SHELL': '/bin/bash', 06:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:46:46 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:46 INFO - 'USER': 'cltbld', 06:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:46 INFO - 'XPC_FLAGS': '0x0', 06:46:46 INFO - 'XPC_SERVICE_NAME': '0', 06:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:47 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 06:46:47 INFO - Cleaning up... 06:46:47 INFO - Return code: 0 06:46:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:47 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:47 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 06:46:47 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 06:46:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:46:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:47 INFO - 'HOME': '/Users/cltbld', 06:46:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:47 INFO - 'LOGNAME': 'cltbld', 06:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:47 INFO - 'MOZ_NO_REMOTE': '1', 06:46:47 INFO - 'NO_EM_RESTART': '1', 06:46:47 INFO - 'PAGER': '/bin/cat', 06:46:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:47 INFO - 'PWD': '/builds/slave/test', 06:46:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:47 INFO - 'SHELL': '/bin/bash', 06:46:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:46:47 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:46:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:47 INFO - 'USER': 'cltbld', 06:46:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:47 INFO - 'XPC_FLAGS': '0x0', 06:46:47 INFO - 'XPC_SERVICE_NAME': '0', 06:46:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:47 INFO - Downloading/unpacking psutil>=3.1.1 06:46:47 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 06:46:47 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 06:46:47 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 06:46:47 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 06:46:47 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 06:46:47 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 06:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:51 INFO - Installing collected packages: psutil 06:46:51 INFO - Running setup.py install for psutil 06:46:51 INFO - building 'psutil._psutil_osx' extension 06:46:51 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 06:46:52 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 06:46:52 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 06:46:52 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 06:46:52 INFO - building 'psutil._psutil_posix' extension 06:46:52 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 06:46:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:46:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:46:52 INFO - ^ 06:46:52 INFO - 1 warning generated. 06:46:52 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 06:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:52 INFO - Successfully installed psutil 06:46:52 INFO - Cleaning up... 06:46:52 INFO - Return code: 0 06:46:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:52 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:52 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 06:46:52 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 06:46:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:46:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:52 INFO - 'HOME': '/Users/cltbld', 06:46:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:52 INFO - 'LOGNAME': 'cltbld', 06:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:52 INFO - 'MOZ_NO_REMOTE': '1', 06:46:52 INFO - 'NO_EM_RESTART': '1', 06:46:52 INFO - 'PAGER': '/bin/cat', 06:46:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:52 INFO - 'PWD': '/builds/slave/test', 06:46:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:52 INFO - 'SHELL': '/bin/bash', 06:46:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:46:52 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:46:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:52 INFO - 'USER': 'cltbld', 06:46:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:52 INFO - 'XPC_FLAGS': '0x0', 06:46:52 INFO - 'XPC_SERVICE_NAME': '0', 06:46:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:46:52 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 06:46:52 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 06:46:52 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 06:46:52 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 06:46:52 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 06:46:52 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 06:46:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:46:55 INFO - Installing collected packages: mozsystemmonitor 06:46:55 INFO - Running setup.py install for mozsystemmonitor 06:46:55 INFO - Successfully installed mozsystemmonitor 06:46:55 INFO - Cleaning up... 06:46:55 INFO - Return code: 0 06:46:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:46:55 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')]} 06:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:55 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')]} 06:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:55 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:55 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 06:46:55 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 06:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:55 INFO - 'HOME': '/Users/cltbld', 06:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:55 INFO - 'LOGNAME': 'cltbld', 06:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:55 INFO - 'MOZ_NO_REMOTE': '1', 06:46:55 INFO - 'NO_EM_RESTART': '1', 06:46:55 INFO - 'PAGER': '/bin/cat', 06:46:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:55 INFO - 'PWD': '/builds/slave/test', 06:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:55 INFO - 'SHELL': '/bin/bash', 06:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:46:55 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:55 INFO - 'USER': 'cltbld', 06:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:55 INFO - 'XPC_FLAGS': '0x0', 06:46:55 INFO - 'XPC_SERVICE_NAME': '0', 06:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:46:56 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 06:46:56 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 06:46:56 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 06:46:56 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 06:46:56 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 06:46:56 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 06:46:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:46:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:46:58 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 06:46:58 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 06:46:58 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 06:46:58 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 06:46:58 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 06:46:58 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 06:46:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:46:59 INFO - warning: no files found matching '*.txt' 06:46:59 INFO - no previously-included directories found matching 'build' 06:46:59 INFO - no previously-included directories found matching 'dist' 06:46:59 INFO - no previously-included directories found matching '.git*' 06:46:59 INFO - Installing collected packages: jsonschema, functools32 06:46:59 INFO - Running setup.py install for functools32 06:46:59 INFO - warning: no files found matching '*.txt' 06:46:59 INFO - no previously-included directories found matching 'build' 06:46:59 INFO - no previously-included directories found matching 'dist' 06:46:59 INFO - no previously-included directories found matching '.git*' 06:46:59 INFO - Successfully installed jsonschema functools32 06:46:59 INFO - Cleaning up... 06:46:59 INFO - Return code: 0 06:46:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:46:59 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')]} 06:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:59 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')]} 06:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:59 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:59 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 06:46:59 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 06:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:59 INFO - 'HOME': '/Users/cltbld', 06:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:59 INFO - 'LOGNAME': 'cltbld', 06:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:59 INFO - 'MOZ_NO_REMOTE': '1', 06:46:59 INFO - 'NO_EM_RESTART': '1', 06:46:59 INFO - 'PAGER': '/bin/cat', 06:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:59 INFO - 'PWD': '/builds/slave/test', 06:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:59 INFO - 'SHELL': '/bin/bash', 06:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:46:59 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:59 INFO - 'USER': 'cltbld', 06:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:59 INFO - 'XPC_FLAGS': '0x0', 06:46:59 INFO - 'XPC_SERVICE_NAME': '0', 06:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:46:59 INFO - Cleaning up... 06:46:59 INFO - Return code: 0 06:46:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:46:59 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')]} 06:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:59 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')]} 06:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:59 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:46:59 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 06:46:59 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 06:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:46:59 INFO - 'HOME': '/Users/cltbld', 06:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:46:59 INFO - 'LOGNAME': 'cltbld', 06:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:59 INFO - 'MOZ_NO_REMOTE': '1', 06:46:59 INFO - 'NO_EM_RESTART': '1', 06:46:59 INFO - 'PAGER': '/bin/cat', 06:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:59 INFO - 'PWD': '/builds/slave/test', 06:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:46:59 INFO - 'SHELL': '/bin/bash', 06:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:46:59 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:46:59 INFO - 'USER': 'cltbld', 06:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:59 INFO - 'XPC_FLAGS': '0x0', 06:46:59 INFO - 'XPC_SERVICE_NAME': '0', 06:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:46:59 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 06:46:59 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 06:46:59 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 06:46:59 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 06:46:59 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 06:46:59 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 06:47:02 INFO - Downloading blobuploader-1.2.4.tar.gz 06:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:47:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:47:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:47:03 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 06:47:03 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 06:47:03 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 06:47:03 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 06:47:03 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 06:47:03 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 06:47:03 INFO - Downloading docopt-0.6.1.tar.gz 06:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:47:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:47:03 INFO - Running setup.py install for blobuploader 06:47:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:47:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:47:04 INFO - Running setup.py install for requests 06:47:04 INFO - Running setup.py install for docopt 06:47:04 INFO - Successfully installed blobuploader requests docopt 06:47:04 INFO - Cleaning up... 06:47:04 INFO - Return code: 0 06:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:04 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')]} 06:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:04 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')]} 06:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:04 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:47:04 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 06:47:04 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 06:47:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:47:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:04 INFO - 'HOME': '/Users/cltbld', 06:47:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:04 INFO - 'LOGNAME': 'cltbld', 06:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:04 INFO - 'MOZ_NO_REMOTE': '1', 06:47:04 INFO - 'NO_EM_RESTART': '1', 06:47:04 INFO - 'PAGER': '/bin/cat', 06:47:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:04 INFO - 'PWD': '/builds/slave/test', 06:47:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:04 INFO - 'SHELL': '/bin/bash', 06:47:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:47:04 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:47:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:04 INFO - 'USER': 'cltbld', 06:47:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:04 INFO - 'XPC_FLAGS': '0x0', 06:47:04 INFO - 'XPC_SERVICE_NAME': '0', 06:47:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-w11TaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-I2VdUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-qeOsQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-eia_QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Oz9VHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-BOBUEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-GCeDRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-TQsMdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:05 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Xvioyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-SSUPpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-mqvGft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-66ZqSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ltF1Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-_CAeHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-hfnEHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-kJVm6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:06 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-N8Ndi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:47:06 INFO - Running setup.py install for manifestparser 06:47:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:47:07 INFO - Running setup.py install for mozcrash 06:47:07 INFO - Running setup.py install for mozdebug 06:47:07 INFO - Running setup.py install for mozdevice 06:47:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:47:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:47:07 INFO - Running setup.py install for mozfile 06:47:07 INFO - Running setup.py install for mozhttpd 06:47:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:47:07 INFO - Running setup.py install for mozinfo 06:47:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:47:07 INFO - Running setup.py install for mozInstall 06:47:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Running setup.py install for mozleak 06:47:08 INFO - Running setup.py install for mozlog 06:47:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Running setup.py install for moznetwork 06:47:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Running setup.py install for mozprocess 06:47:08 INFO - Running setup.py install for mozprofile 06:47:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:47:08 INFO - Running setup.py install for mozrunner 06:47:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:47:09 INFO - Running setup.py install for mozscreenshot 06:47:09 INFO - Running setup.py install for moztest 06:47:09 INFO - Running setup.py install for mozversion 06:47:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:47:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:47:09 INFO - Cleaning up... 06:47:09 INFO - Return code: 0 06:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:09 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:47:09 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 06:47:09 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 06:47:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:47:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:09 INFO - 'HOME': '/Users/cltbld', 06:47:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:09 INFO - 'LOGNAME': 'cltbld', 06:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:09 INFO - 'MOZ_NO_REMOTE': '1', 06:47:09 INFO - 'NO_EM_RESTART': '1', 06:47:09 INFO - 'PAGER': '/bin/cat', 06:47:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:09 INFO - 'PWD': '/builds/slave/test', 06:47:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:09 INFO - 'SHELL': '/bin/bash', 06:47:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:47:09 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:47:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:09 INFO - 'USER': 'cltbld', 06:47:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:09 INFO - 'XPC_FLAGS': '0x0', 06:47:09 INFO - 'XPC_SERVICE_NAME': '0', 06:47:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:09 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-newcw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:09 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)) 06:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:09 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-IhIapn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-C6SZOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Sls9GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-2gRCB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-9r3aIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-pEMUrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Jw__bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-khYFld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Igf2qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Md0vS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:10 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)) 06:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:10 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-u56w3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:11 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-cjDHqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:11 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)) 06:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:11 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-AfGB4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:11 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)) 06:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:11 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-3ZYzC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:11 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)) 06:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:11 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-iWNBke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:11 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)) 06:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:11 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-4c73pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:11 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)) 06:47:11 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)) 06:47:11 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)) 06:47:11 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)) 06:47:11 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)) 06:47:11 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)) 06:47:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:14 INFO - Downloading blessings-1.6.tar.gz 06:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:47:14 INFO - Installing collected packages: blessings 06:47:14 INFO - Running setup.py install for blessings 06:47:14 INFO - Successfully installed blessings 06:47:14 INFO - Cleaning up... 06:47:14 INFO - Return code: 0 06:47:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:14 INFO - Reading from file tmpfile_stdout 06:47:14 INFO - Current package versions: 06:47:14 INFO - blessings == 1.6 06:47:14 INFO - blobuploader == 1.2.4 06:47:14 INFO - docopt == 0.6.1 06:47:14 INFO - functools32 == 3.2.3-2 06:47:14 INFO - jsonschema == 2.5.1 06:47:14 INFO - manifestparser == 1.1 06:47:14 INFO - mozInstall == 1.12 06:47:14 INFO - mozcrash == 1.0 06:47:14 INFO - mozdebug == 0.1 06:47:14 INFO - mozdevice == 0.49 06:47:14 INFO - mozfile == 1.2 06:47:14 INFO - mozhttpd == 0.7 06:47:14 INFO - mozinfo == 0.9 06:47:14 INFO - mozleak == 0.1 06:47:14 INFO - mozlog == 3.4 06:47:14 INFO - moznetwork == 0.27 06:47:14 INFO - mozprocess == 0.25 06:47:14 INFO - mozprofile == 0.28 06:47:14 INFO - mozrunner == 6.13 06:47:14 INFO - mozscreenshot == 0.1 06:47:14 INFO - mozsystemmonitor == 0.3 06:47:14 INFO - moztest == 0.8 06:47:14 INFO - mozversion == 1.4 06:47:14 INFO - psutil == 3.1.1 06:47:14 INFO - requests == 1.2.3 06:47:14 INFO - wsgiref == 0.1.2 06:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:14 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:47:14 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 06:47:14 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 06:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:14 INFO - 'HOME': '/Users/cltbld', 06:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:14 INFO - 'LOGNAME': 'cltbld', 06:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:14 INFO - 'MOZ_NO_REMOTE': '1', 06:47:14 INFO - 'NO_EM_RESTART': '1', 06:47:14 INFO - 'PAGER': '/bin/cat', 06:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:14 INFO - 'PWD': '/builds/slave/test', 06:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:14 INFO - 'SHELL': '/bin/bash', 06:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:47:14 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:14 INFO - 'USER': 'cltbld', 06:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:14 INFO - 'XPC_FLAGS': '0x0', 06:47:14 INFO - 'XPC_SERVICE_NAME': '0', 06:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 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)) 06:47:15 INFO - Cleaning up... 06:47:15 INFO - Return code: 0 06:47:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:47:15 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')]} 06:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:15 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')]} 06:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:15 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 0x104927b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87024e2d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, '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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 06:47:15 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 06:47:15 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 06:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:15 INFO - 'HOME': '/Users/cltbld', 06:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:15 INFO - 'LOGNAME': 'cltbld', 06:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:15 INFO - 'MOZ_NO_REMOTE': '1', 06:47:15 INFO - 'NO_EM_RESTART': '1', 06:47:15 INFO - 'PAGER': '/bin/cat', 06:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:15 INFO - 'PWD': '/builds/slave/test', 06:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:15 INFO - 'SHELL': '/bin/bash', 06:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:47:15 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:15 INFO - 'USER': 'cltbld', 06:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:15 INFO - 'XPC_FLAGS': '0x0', 06:47:15 INFO - 'XPC_SERVICE_NAME': '0', 06:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:47:15 INFO - Cleaning up... 06:47:15 INFO - Return code: 0 06:47:15 INFO - Running post-action listener: _resource_record_post_action 06:47:15 INFO - Running post-action listener: _start_resource_monitoring 06:47:15 INFO - Starting resource monitoring. 06:47:15 INFO - [mozharness: 2017-03-30 13:47:15.371092Z] Finished create-virtualenv step (success) 06:47:15 INFO - [mozharness: 2017-03-30 13:47:15.372110Z] Running install step. 06:47:15 INFO - Running pre-action listener: _resource_record_pre_action 06:47:15 INFO - Running main action method: install 06:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:15 INFO - Reading from file tmpfile_stdout 06:47:15 INFO - Detecting whether we're running mozinstall >=1.0... 06:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:47:15 INFO - Reading from file tmpfile_stdout 06:47:15 INFO - Output received: 06:47:15 INFO - Usage: mozinstall [options] installer 06:47:15 INFO - Options: 06:47:15 INFO - -h, --help show this help message and exit 06:47:15 INFO - -d DEST, --destination=DEST 06:47:15 INFO - Directory to install application into. [default: 06:47:15 INFO - "/builds/slave/test"] 06:47:15 INFO - --app=APP Application being installed. [default: firefox] 06:47:15 INFO - mkdir: /builds/slave/test/build/application 06:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:47:36 INFO - Reading from file tmpfile_stdout 06:47:36 INFO - Output received: 06:47:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:47:36 INFO - Running post-action listener: _resource_record_post_action 06:47:36 INFO - [mozharness: 2017-03-30 13:47:36.346241Z] Finished install step (success) 06:47:36 INFO - [mozharness: 2017-03-30 13:47:36.346379Z] Running run-tests step. 06:47:36 INFO - Running pre-action listener: _resource_record_pre_action 06:47:36 INFO - Running main action method: run_tests 06:47:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:47:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:47:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:47:36 INFO - 2017-03-30 06:47:36.360 screenresolution[1639:10042] starting screenresolution argv=screenresolution get 06:47:36 INFO - 2017-03-30 06:47:36.363 screenresolution[1639:10042] Display 0: 1600x1200x32@60 06:47:36 INFO - 2017-03-30 06:47:36.369 screenresolution[1640:10045] starting screenresolution argv=screenresolution list 06:47:36 INFO - Available Modes on Display 0 06:47:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:47:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:47:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:47:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:47:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:47:36 INFO - Intel Iris: 06:47:36 INFO - Chipset Model: Intel Iris 06:47:36 INFO - Type: GPU 06:47:36 INFO - Bus: Built-In 06:47:36 INFO - VRAM (Dynamic, Max): 1536 MB 06:47:36 INFO - Vendor: Intel (0x8086) 06:47:36 INFO - Device ID: 0x0a2e 06:47:36 INFO - Revision ID: 0x0009 06:47:36 INFO - Displays: 06:47:36 INFO - Display: 06:47:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:47:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:47:36 INFO - Display Serial Number: 1600x1200 60 06:47:36 INFO - Main Display: Yes 06:47:36 INFO - Mirror: Off 06:47:36 INFO - Online: Yes 06:47:36 INFO - Rotation: Supported 06:47:36 INFO - Return code: 0 06:47:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:47:36 INFO - Python 2.7.3 06:47:36 INFO - Return code: 0 06:47:36 INFO - grabbing minidump binary from tooltool 06:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:36 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 0x104705d30>, '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 0x10462cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046fabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:47:36 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 06:47:36 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 06:47:36 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 06:47:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:47:36 INFO - Return code: 0 06:47:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:47:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:47:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:47:36 INFO - ENV: RUST_BACKTRACE is now 1 06:47:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:47:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:47:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 06:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --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 06:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t3fi7R31Al/Render', 06:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:36 INFO - 'HOME': '/Users/cltbld', 06:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:36 INFO - 'LOGNAME': 'cltbld', 06:47:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:47:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:36 INFO - 'MOZ_NO_REMOTE': '1', 06:47:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:47:36 INFO - 'NO_EM_RESTART': '1', 06:47:36 INFO - 'PAGER': '/bin/cat', 06:47:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:36 INFO - 'PWD': '/builds/slave/test', 06:47:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:36 INFO - 'RUST_BACKTRACE': '1', 06:47:36 INFO - 'SHELL': '/bin/bash', 06:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RJmaQ4ZXOz/Listeners', 06:47:36 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 06:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:36 INFO - 'USER': 'cltbld', 06:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:36 INFO - 'XPC_FLAGS': '0x0', 06:47:36 INFO - 'XPC_SERVICE_NAME': '0', 06:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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 06:47:36 INFO - mozversion application_buildid: 20170330060421 06:47:36 INFO - mozversion application_changeset: fa249f1c67934d6d3bdb4048bf43d313412507bc 06:47:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:47:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:47:36 INFO - mozversion application_name: Firefox 06:47:36 INFO - mozversion application_remotingname: firefox-dev 06:47:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:47:36 INFO - mozversion application_vendor: Mozilla 06:47:36 INFO - mozversion application_version: 54.0a2 06:47:36 INFO - mozversion platform_buildid: 20170330060421 06:47:36 INFO - mozversion platform_changeset: fa249f1c67934d6d3bdb4048bf43d313412507bc 06:47:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:47:36 INFO - mozversion platform_version: 54.0a2 06:47:36 INFO - using testdate: 1490881656 06:47:36 INFO - actual date: 1490881656 06:47:36 INFO - starting webserver on 'localhost:49241' 06:47:36 INFO - SUITE-START | Running 2 tests 06:47:36 INFO - TEST-START | dromaeo_css 06:47:36 INFO - operating with platform_type : mac_ 06:47:36 INFO - Initialising browser for dromaeo_css test... 06:47:36 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpbn03tp/profile http://localhost:49241/getInfo.html) 06:47:39 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 06:47:39 INFO - PROCESS | 1650 | colorDepth:24 06:47:39 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 06:47:39 INFO - PROCESS | 1650 | __metrics 06:47:39 INFO - PROCESS | 1650 | 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" 06:47:39 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:40 INFO - TEST-INFO | 1650: exit 0 06:47:40 INFO - Browser initialized. 06:47:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:47:40 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpbn03tp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:52 INFO - PROCESS | 1653 | RSS: Main: 215072768 06:47:52 INFO - PROCESS | 1653 | 06:50:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:50:58 INFO - PROCESS | 1653 | RSS: Main: 394268672 06:50:58 INFO - PROCESS | 1653 | 06:52:41 INFO - PROCESS | 1653 | ************************* 06:52:41 INFO - PROCESS | 1653 | A coding exception was thrown and uncaught in a Task. 06:52:41 INFO - PROCESS | 1653 | 06:52:41 ERROR - PROCESS | 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:52:41 INFO - PROCESS | 1653 | Full stack: 06:52:41 INFO - PROCESS | 1653 | ************************* 06:54:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:54:02 INFO - PROCESS | 1653 | RSS: Main: 353710080 06:54:02 INFO - PROCESS | 1653 | 06:57:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:57:05 INFO - PROCESS | 1653 | RSS: Main: 347553792 06:57:05 INFO - PROCESS | 1653 | 07:00:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:00:08 INFO - PROCESS | 1653 | RSS: Main: 347058176 07:00:08 INFO - PROCESS | 1653 | 07:03:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:03:13 INFO - PROCESS | 1653 | RSS: Main: 323829760 07:03:13 INFO - PROCESS | 1653 | 07:06:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:06:17 INFO - PROCESS | 1653 | RSS: Main: 477523968 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | __start_tp_report 07:06:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:06:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:06:17 INFO - PROCESS | 1653 | |i|pagename|runs| 07:06:17 INFO - PROCESS | 1653 | |0;dojo.html;3380.729541636669;3381.374445727539;3387.1362802485364;3388.7966721996677;3427.4687423449373;4685.554872287135;5769.682667453289;5778.7977420790285;5838.211841401415;5851.736671849766;5760.423957604237;5829.446202610745;5848.4736373726355;5856.736446859891;5859.121131830228;5235.581153507729;5275.446078161795;5279.445658205891;5320.600954928376;5365.651232669864;5167.948320516784;5188.766505507261;5353.625246232766;5389.622726409153;5389.622726409153;5237.004969055886;5270.5520030797425;5291.735413229342;5296.788128474856;5298.92051619226;5269.789208431658;5290.603204759658;5291.629585928987;5301.575873930076;5311.814086506954;5152.92270615941;5236;5260.316158899357;5262.60530460217;5277.419483856773;5780.306363236438;5781.942180578182;5789.797357092523;5790.942090579082;5791.913121303184;6167.259928808572;6180.165677633507;6182.1345011698395;6182.443580077815;6183.505319574423;6266.530010249249;6266.811995640138;6277.089821975834;6284;6323.36766323364;5877.9118313225335;5914.9112763308585;5927.703614819242;5931.080682494177;5967.6419414835245;6238.095476155932;6324.778632747832;6368.14030105939;6378.138951241569;6382.968085159591;6134.589663226396;6139.597154504007;6197.225346831646;6204.410580994889;6267.62394256346;6334.746610135635;6352.872942541123;6361.713722882481;6364.77723279683;6380.330065343165;6357.396047375492;6365.61806291624;6376.458001069961;6390.584612000205;6390.680465976682;6048.0625503047095;6155.384461553809;6291.213598300213;6353.364663533702;6399.488040956712;4478.664100192498;5016.423111342169;5062.417821950449;5070.721110338966;5094.566961808214;4529.932051019237;4537.183307004705;4537.636989040869;4545.568171023748;4574.313852922089;5889.1755154278435;5935.139404786281;5939.524838013035;5947.107933809876;5953;6194.163787888668;6202.131701561785;6295.716692748837;6323.177986861679;6338.334474880164;5883.0881213411985;5888;5953.940460595425;5955.076963070731;5983.132445795335;4690.484046754854;5544.61187716856;5548.0845660466375;5554.944450555524;5557.249771280906;6221.222347206599;6409.7115629795835;6416.390442907917;6455.935440645628;6465.321141280286;5179.22311653255;6308.495320374451;6314.905276420949;6318.684065796784;6319.3364696706185;6293.590916590407;6299.622022678654;6329.8734025320155;6331.2085989251345;6335.588186767845;6332.715027823667;6354.745810167727;6359.8092057238355;6377.553571249968;6404.423601875854;6303.1175635412;6326.4622507087415;6343.429091381798;6344.111824344688;6362.840928976812;6047.909281360695;6094.268687757498;6195.690215489298;6219.657918814328;6305;5095.363079615048;6258.874822503433;6260.561760676709;6286;6288.937110628835;6117.632942023492;6122.173506576555;6127.20346354971;6133.478654314434;6135.325114237341;6005;6023.27720673522;6301.558890877594;6330.177076979963;6346.428821405911;5952.970235148797;6007.87984240304;6101.145839582551;6119.326874043941;6139.6009259398 07:06:17 INFO - PROCESS | 1653 | |1;ext.html;687.5359132585504;715.3311653603878;788.6805843633327;856.91859273369;868.617808164408;27136;39197.608023919754;39610.80194599023;39635.405468917954;39959;39809.805705828796;39995.60004399955;40035.59964400355;40067.398989015186;40156.79921600395;7329.303716146984;9006.45961242326;9106.13491718289;9133.771655708593;9137.40606860552;7455.440841936849;10931.289466184673;11081.113510919147;11170;11173.497192626312;11001.22991390603;11037.724056898562;11047.116230701524;11055;11094.55621775128;7214.603196824172;10984.06635435989;11003.61487347947;11014.39420831858;11018.669439916815;7246.96376518114;10574.735631609194;10822.404767737771;10897.182711296684;10922.672319830417;38132.61867381319;38159.855204343636;38180;38199.427008594896;38299;3741.307858046243;3766.9058273543105;3781.300459415017;3798.126430920876;3879.7478163919254;26529.071482498213;26621.06826261091;26904.327391815164;26976.325591860164;27939.88240470379;3025.833579153146;3083.8766449342;3099.02380750063;3152.4640811061945;3158.6683398243313;326122;326484;326665.3666731651;326683;327043.36478317453;50464.990700185794;50556.49443505518;50585.747071264406;50673.49326506688;50729.492705073215;52328.73835630798;52331;52347.73826130921;52382.69043273949;52516.94966100733;14390.784138237936;14529.692327690558;14535.927320363542;14558.708825823423;14562.635934101732;10925.125989920787;11036.227464077438;12532.436040378205;12540.81188782169;12548.24710517372;10641.680749577525;11849.466773995191;11928.403579820973;12179.817302740466;12315.322657253937;5281.0758117329315;5300.602454815904;5300.734963251822;5308.708021058879;5320.334958130234;978.2272005115879;1138.5218208352512;1141.7773534160924;1144.1476100305326;1144.3991904250336;24733.010679572617;25729.22812315596;26178.08376706806;26660.866695666784;26757.331066723487;850.2452055340775;1075.989240107589;1124.454639499842;1132.6205721083365;1169.4094482286391;11108.61119860801;12700.80948785769;12878.034147438979;12953.287569183596;12972.80540791889;322130;324006;324053.37973310455;325005;325130;51280.743596281776;51480.22779658308;51487;51557.74221128871;51875.48124518782;1423.6973169549954;1465.3113036872653;1479.7484427647325;1480.3930388540646;1481.9555413337616;21198.682019769407;23500;24706;24863.87568062148;27081.912706747487;44798.552014480745;45037.32444013277;45121;45165.322520161564;45187.77406112949;455511;458437;459043;460240;460276;28855.845766169117;29022.839086436306;29028.564571531868;29035.854820725763;29050.564241535973;36820;37455.81272093622;37770;37805.62194378021;37826.810865946594;25741.485170296863;27012;27217.183484495497;27948;28016.159515214575;22017.779822201574;26009.21972340833;26676.199714007835;26766.19701408961;27211.455770884866;30615.928442504406;30951;31455;31513;31541;25295.620565691162;25569.872150639127;26667.466650667266;26921.326966825985;27240.580173413062;21238.36284911455;22255.888720556293;22278;23501.529969400857;24146.51706965886 07:06:17 INFO - PROCESS | 1653 | |2;jquery.html;385.78781670081446;406.81489922085456;416.34425779397446;424.22578793701496;441.4151249594286;11794.469248883799;14468.782968255471;20516.589668206627;20805.895970520163;21278.361649150513;21349.893250533725;21544.245951391706;22165.891705414706;22486;22826.543469130607;5924.200232968537;6766.729330826761;6811.795646130624;6983.16202055754;6987.580745155307;4208.831646734127;4510.345999830022;6834.589924604539;6957.756478523227;6958.304169583026;4480;7969.521828690297;8010.5594192319395;8010.919890801105;8017.95991020047;7813.843723125534;7956.005499312586;7961.800954976114;7998.36013118952;8051.074126475413;7512.812179695551;7750.418718596128;7789.143194248628;7801.29788319054;7838.216178382173;27058.72941270582;27129.728702712917;27192.824574034028;27213.45573088547;27476.725232747816;2874.2814296425895;2946.616939797834;2956.4382767274365;2957.8225306481463;3001.429728351628;16001;16223.594410139724;16461.25924333408;16567.50297491077;17167.141642917803;1919.4721451600783;2008.4978755311172;2010.5174758058106;2012.164951545107;2037.0833125093618;164715.1764241183;166953;171441;173441;174796;19767.813931164175;19785.40643780689;19863.205471781257;19967.20131194765;20050.899745501178;31309.8434507826;31428.685713143033;31491.212719681735;31579.684203158133;31598.894038708535;10149.746256343502;10161.237907156992;10287.537060832281;10340.689779306633;10501.737456563647;6953.582785032813;8556.229939305493;8568.186022327869;8740.257078148301;8778.95610521956;8997;9126.49804260772;9207.90792092084;9224;9225.800645916122;3139.4662907305815;3140.638826534932;3448.965110584767;3531.7168261293114;3681.7790932544135;997.5660587644398;1002.5989604158249;1004.8090862736057;1007.4610083605236;1049.302214027663;15968.76046859298;19783.802161978485;19970.90014549918;20036.599268014557;20069;973.9951300243454;977.3207620703542;1011.630754774502;1017.7913527726798;1023.8924912884189;9922.900770992197;10582.576696932036;10653.520591573399;10710;10763;622577;624127;630291;675590;703188;151597;152686;152805.47194527913;155528;158384.20807895888;1159.0176038549644;1181.8877206665354;1207.5169932027084;1210.0440651885087;1211.8485189351507;17349.913250434172;18020;18081.095945202425;18173;18488.35290764817;41262.79368603138;60156;61010.389896100474;61167.69416152891;62037.37962620316;83976;84151.57924210584;84399.5780021096;84748.57625711831;87351.56324218339;10842.566297348334;10893.183011274345;11352.318860868374;11360.715982100513;11632.18574699763;12431.75136497247;12473.376331183223;12736.87263127394;12763.87236127664;12897.548585799452;10501.369917804956;10858.457077145953;10979.451027448436;10997.285176463503;10998.230123891572;7596.8480630388185;8474.491530508189;10320.12278956297;10407.115395191191;10496.947515262375;11049.5027723751;11217.495212715285;11327.943360283145;11328;11363.886361136614;11031.282966607145;11439.885601143882;11450.141239406912;11459.4270286487;11470.4264786762;10684.252102353072;10721.731956701145;11021.61424350176;11060.889391105986;11235.325880446871 07:06:17 INFO - PROCESS | 1653 | |3;mootools.html;1529.2583097197864;1530.3496014193965;1555.1213564336142;1586.4288856011833;1590.9443169489066;8502.702405415805;11056.336619802818;11063.502142403591;11070.612528561502;11079.833802492969;9289.581968811402;10472.16222702184;10831.945840270788;10941.23411361205;10959.12327013839;2041.4998325410295;2306.3426923326856;2317.6523521471745;2347.0494449747794;2349.635806450003;2197.494576247464;2207.5915955548194;2210.18223257395;2210.546837898227;2296.1848543766973;2209.193644319828;2213.0594497338648;2217.1796435318956;2219.1234462387347;2330.5571941331177;2239.675247089163;2299.908003679851;2307.861528308307;2308.595995700754;2310.3761984264156;2319.4665226997886;2333.4516388648653;2335.311083230451;2339.5671800716923;2349.917752878658;10833.891661083368;10915.781684366268;10919.508622112024;10925.781484370347;10933.398663073527;5380.542653874425;5535.667859928377;5536.612437129403;5539.944600553983;5543.113101903676;3128.1866714654125;3211.678832116793;3402.2515046689687;3410.84651190697;3421.623621401644;1124.5614210457927;1139.481535901163;1148.7759886822073;1167.4512978899904;1176.941152942358;13677.452901883913;13938.790918136236;14244.00291979562;15448.536543903701;15541.98977066487;3772.867949621805;4345.543717909574;4488.079943611552;4494.303382975579;4513.75174365413;11489;11507.367094809699;11512.251703639236;11512.366819824823;11515.30908145514;4685.1332503486965;4856.514348565186;5315.069862773999;5446.972765136228;5449.073657478239;5016.322796422436;5112.258722485219;5133;5137.332146820964;5144.176931690911;3619.4208926571623;3683.9447408288897;3699.093722038118;3757.0231739747865;3760.304343696425;800.5956991719145;935.2611436964858;936.9672061477816;942.2038377570941;948.0661548374845;921.5760750054916;935.5976929920199;943.613118621362;946;994.8457989011715;6517.348265173445;6541.8691626168165;6621.304762999912;6784.660766961632;6807.863842723118;1011.1354791653177;1033.6950599573145;1063.9893601064045;1103.5254840418536;1105.0883021507289;4088.836446542105;4126.133511962522;4153.127843152912;4302.784860757012;4306.978465107654;13718.93140534291;14246.002779805314;14252.429902803771;14274;14281.214533200566;12892.097553171188;13329.66675833112;13474.865251347557;13502.122362046435;14030.298485075706;9976.401415915068;10204.183665306906;10229.897701023043;10249.743756406;10284.6115774371;6386.9361306386345;6641;6811.489138314745;6818.113645226089;6856.108705868404;12097.57658481949;12227.510899563918;12343.259404435763;12363.505459781509;12364.814527781911;11348.602798901999;11507.136964727511;12298.569550065704;12471.127021108436;12480.126391152895;9175.08249175077;9450.291228157777;9460.101290377403;9485.146336829719;9486.098820612031;10002;10174.796504070026;10317.845232321371;10321.535530900977;10342.844857326996;8515.361347898808;8718.041015488418;8740.956295218482;8810.735677929672;9109.22571581423;8491.78770530717;8496.660133594834;8539.103394143525;8581.613827377658;8609.569521523774;7797.649105790139;7825.569593672402;7884.29041386278;7917.564533950688;7924.009498812648;5762.423757624371;5770.913436298375;5853.531717462678;5931.466168044896;6012.188354572252;5811.4479124483105;5936.13925980739;5937.2578427696535;5970.940290597212;6057.879292330933 07:06:17 INFO - PROCESS | 1653 | |4;prototype.html;363.7999100494727;372.4952689106261;380.43695330910253;380.528145100076;383.62213219978315;4778.208171935528;4802.59177969873;5089.208539637965;5136.4093129290095;5141.742912854361;3810.676092532131;4154.543000269976;4219.894502637436;4633.513481084488;4929.679570827893;3489.1681867019765;3866.6520013198806;4152.750834949898;4158.9376159357635;4163.625273725356;4033.899152521181;4200.663946884257;4207.948012996751;4209.768462734548;4215.641670458015;3309.4776402854714;3408.7102596279346;4196.433481480007;4197.643200327976;4203.30645443503;3654.7258955578304;4103.343465045608;4103.876883693494;4127.236461254647;4157.230912281222;3445.104272889042;3664.468652045465;3801.5818259991656;3811.313963486571;3839.4240863870364;3956.40653901917;4049.906525238199;4095.7268715862683;4545.977270113662;4892.412910450768;3607.7113830893463;4653.859804347956;4834.58905992991;4844.66087373884;4861.003494283698;5350.438203988564;5376.865578360533;5382.3541175059245;5442.292501974757;5444.265024221759;3903.726739128262;4236.597523235288;4545.999880026389;4692.389989301369;4698.248280275139;4549.727016379028;5286.947130528684;5560.749766260487;5656.349519805234;5689.943100568983;4222.366645003212;4541.6593755468475;4590.540945905383;4605.443978591914;4607.884802879955;3827.8468861245237;4055.9391609125887;4692.788824502905;4723.716577005391;4749.548792864673;4493.977710030499;4713.740744259098;4722.881927951828;4900.779464924087;4947.529984651453;4299.763513006752;4380.934285985712;4939.357883475197;5338.008961620897;5341.919871201935;1655.0470444874923;1665.7340421279914;1667.9317646118725;1679.3030892179852;1696.6437048220012;1151.332227308176;1267.4233223883111;1326.0717497751612;1364.3519328319167;1394.9442022318995;4496.9325460118125;4650.51169627191;4892.926606100911;4954.677945933575;4965.751712414365;4713.457952335457;5123.538881500608;5291.148098165688;5433.809816656398;5458;3952.73105046549;4391.978040109779;4414.761828644538;4481.977590112094;4926;2451.240115564181;2626.487834872182;2667.7599016088643;2789.4839454700946;2817.6892151721645;5213;5556.3050571370395;5786.582287339545;5793.740441227925;5795.88408231833;4605.447346318463;4897.632677549198;5360.5960215263585;5674;5787.479126878601;5241.711705856214;5256;5506;5651.745671444794;5822.272215973004;4604.441602813257;4783.497732738151;5394.919076213781;5574.857154283443;5610.298712660918;5211.869703257449;5231.686098834082;5497.972510137423;5524.038966166953;5546.389897111234;4894.241392584155;5071.568916641979;5338.439463856239;5457.345118585795;5824.835032993334;4252.064545799919;4252.447181866338;4403.512015711113;4427.601515863587;4433.224185767543;4950.554450099508;5383;5553.805616803393;5589.161625756169;5603.870529198878;5364.953834002332;5387.86530336729;5392.357744705145;5403.837884863303;5434.673919564839;4561.201789686858;4602.631789456902;4756.9524304756505;4844.079624871263;5412.995787338065;5241.947580524298;5263.289455923555;5268.894622107613;5282.920756188583;5289.7619607117;4625.6530760192445;5178.663386879992;5410.594205434687;5422.755975981169;5440.428754980829;4806.221697971773;5094.898102038012;5146.202338637517;5209.218617207449;5287.629865909504 07:06:17 INFO - PROCESS | 1653 | |5;yui.html;712.9572225666457;744.2111361956323;757.594686842539;822.4571782623468;824.6824972385631;15127.848721512795;15763.290651920663;15896.443624473146;16009.599760006005;16074;14290.857091429083;16417.343306267736;17210.483685489424;17402.303907843703;17571.297148114092;924.8751418558476;955.6464108279912;958.4632605740773;960.3805545423198;960.8750862387915;919.6459363145203;940.4968341937065;953.0374321934861;955.2310390135938;956.9665061722841;1002.9498525073753;1006.7483129217695;1007.1338648762095;1007.9647212347569;1008.3848852200152;993.9055789699967;997.4663554998041;998.5456617239175;998.6155330197854;999.6601155607092;740.829609189884;741.0403527431935;741.7144399406213;742.5544673196039;743.2121950732242;15532.301046452936;15995.600109997227;16014.519564413085;16195.271212795453;16471;12728.61814145577;12747.936260318638;13045.608631741063;13046;13305.334733263395;11469.197156199069;11571.299993535617;11768;12209.023278137727;12305.44625491855;3540.698051866994;3576.8926932192076;3647.2340808430263;3658.926821463556;3735.9439608405896;116206;117280.41359793232;118035;119572.40213798963;121579.35261942155;9166.450012999241;10359.689209323733;10699.090577300862;10957.616483423042;11298.830517542243;21545.569088618453;21572.784272157078;21630.134794608355;21827.563448731253;21963.341099767033;7536.171021187665;7589.696412143563;7743.341815945595;8002.9599852000365;8019.879701804478;4268.658507319407;4319.114581510783;4323.783810809447;4419.558044195554;4511.593956543861;3419.965800341965;3478.095695119287;3495.4582039783872;3516.0506663201304;3521.1549228185563;552.6407834907343;611.7950486586955;615.0374663651461;617.2901163661825;624.0452108274347;629.196507114494;663.741140955028;692.2074225012333;692.9792106236821;725.6553137259759;9594.154792342651;10146.847797283046;10200.918112536032;10258.948705256425;10446.164306855433;638.3393188050345;705.1714235773048;716.6631683108931;719.0400814912047;723.4429489293215;4696.553827386393;4943.5797957174045;4945.159322915113;4953.281774142729;4960.280759289883;77160.61419692865;104029.47985260026;104746;105567.47216263869;106902;57641.13538296929;58697.70651146717;66972;68686;90045.4977251148;75545.48909021789;76076;76746;78026.60986695143;79279;10802.567897284021;10962.958518940688;11025.393603351893;11167.38579378142;11181.608643697431;32348;44528.66414007585;47662.28506572473;48426.75786621044;48776.5122348772;59086.40913590809;64925.67537162284;65355.019674705865;66932.33067669261;66983.66508167428;11819.645410637695;11919.761604767682;12321.630351089481;12797.744045119232;12824.679383015125;13441.798373024218;14586.4894728684;14683.55949321522;14747.778783318045;15210.543683689508;11869.762604747684;12900.612981610566;13431.597052088453;13625.931870340584;13803;12938.417771200131;13663.9752018601;13773.862261377259;13783.035187536776;13920.373583188579;12445.026853699486;13623.79564306556;13744.725105498033;13903.721925561635;13929.651758706113;9038.32212584072;9343.252539796664;9491.193248573949;9503.952480237554;9855.655052073143;8383.706570270011;10232.948835255776;11076.446177690923;11175.21773475849;11577.189596728149 07:06:17 INFO - PROCESS | 1653 | __end_tp_report 07:06:17 INFO - PROCESS | 1653 | __start_cc_report 07:06:17 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1822 07:06:17 INFO - PROCESS | 1653 | __end_cc_report 07:06:17 INFO - PROCESS | 1653 | __startTimestamp1490882776998__endTimestamp 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:06:17 INFO - PROCESS | 1653 | Number of tests: 6 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5818.38 Median:6048.06 stddev:661.30 (10.9%) stddev-sans-first:635.08 07:06:17 INFO - PROCESS | 1653 | Values: 3380.7 3381.4 3387.1 3388.8 3427.5 4685.6 5769.7 5778.8 5838.2 5851.7 5760.4 5829.4 5848.5 5856.7 5859.1 5235.6 5275.4 5279.4 5320.6 5365.7 5167.9 5188.8 5353.6 5389.6 5389.6 5237.0 5270.6 5291.7 5296.8 5298.9 5269.8 5290.6 5291.6 5301.6 5311.8 5152.9 5236.0 5260.3 5262.6 5277.4 5780.3 5781.9 5789.8 5790.9 5791.9 6167.3 6180.2 6182.1 6182.4 6183.5 6266.5 6266.8 6277.1 6284.0 6323.4 5877.9 5914.9 5927.7 5931.1 5967.6 6238.1 6324.8 6368.1 6378.1 6383.0 6134.6 6139.6 6197.2 6204.4 6267.6 6334.7 6352.9 6361.7 6364.8 6380.3 6357.4 6365.6 6376.5 6390.6 6390.7 6048.1 6155.4 6291.2 6353.4 6399.5 4478.7 5016.4 5062.4 5070.7 5094.6 4529.9 4537.2 4537.6 4545.6 4574.3 5889.2 5935.1 5939.5 5947.1 5953.0 6194.2 6202.1 6295.7 6323.2 6338.3 5883.1 5888.0 5953.9 5955.1 5983.1 4690.5 5544.6 5548.1 5554.9 5557.2 6221.2 6409.7 6416.4 6455.9 6465.3 5179.2 6308.5 6314.9 6318.7 6319.3 6293.6 6299.6 6329.9 6331.2 6335.6 6332.7 6354.7 6359.8 6377.6 6404.4 6303.1 6326.5 6343.4 6344.1 6362.8 6047.9 6094.3 6195.7 6219.7 6305.0 5095.4 6258.9 6260.6 6286.0 6288.9 6117.6 6122.2 6127.2 6133.5 6135.3 6005.0 6023.3 6301.6 6330.2 6346.4 5953.0 6007.9 6101.1 6119.3 6139.6 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:50530.37 Median:16038.20 stddev:99397.03 (619.8%) stddev-sans-first:99605.42 07:06:17 INFO - PROCESS | 1653 | Values: 687.5 715.3 788.7 856.9 868.6 27136.0 39197.6 39610.8 39635.4 39959.0 39809.8 39995.6 40035.6 40067.4 40156.8 7329.3 9006.5 9106.1 9133.8 9137.4 7455.4 10931.3 11081.1 11170.0 11173.5 11001.2 11037.7 11047.1 11055.0 11094.6 7214.6 10984.1 11003.6 11014.4 11018.7 7247.0 10574.7 10822.4 10897.2 10922.7 38132.6 38159.9 38180.0 38199.4 38299.0 3741.3 3766.9 3781.3 3798.1 3879.7 26529.1 26621.1 26904.3 26976.3 27939.9 3025.8 3083.9 3099.0 3152.5 3158.7 326122.0 326484.0 326665.4 326683.0 327043.4 50465.0 50556.5 50585.7 50673.5 50729.5 52328.7 52331.0 52347.7 52382.7 52516.9 14390.8 14529.7 14535.9 14558.7 14562.6 10925.1 11036.2 12532.4 12540.8 12548.2 10641.7 11849.5 11928.4 12179.8 12315.3 5281.1 5300.6 5300.7 5308.7 5320.3 978.2 1138.5 1141.8 1144.1 1144.4 24733.0 25729.2 26178.1 26660.9 26757.3 850.2 1076.0 1124.5 1132.6 1169.4 11108.6 12700.8 12878.0 12953.3 12972.8 322130.0 324006.0 324053.4 325005.0 325130.0 51280.7 51480.2 51487.0 51557.7 51875.5 1423.7 1465.3 1479.7 1480.4 1482.0 21198.7 23500.0 24706.0 24863.9 27081.9 44798.6 45037.3 45121.0 45165.3 45187.8 455511.0 458437.0 459043.0 460240.0 460276.0 28855.8 29022.8 29028.6 29035.9 29050.6 36820.0 37455.8 37770.0 37805.6 37826.8 25741.5 27012.0 27217.2 27948.0 28016.2 22017.8 26009.2 26676.2 26766.2 27211.5 30615.9 30951.0 31455.0 31513.0 31541.0 25295.6 25569.9 26667.5 26921.3 27240.6 21238.4 22255.9 22278.0 23501.5 24146.5 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:40371.70 Median:11276.84 stddev:110250.67 (977.7%) stddev-sans-first:110519.08 07:06:17 INFO - PROCESS | 1653 | Values: 385.8 406.8 416.3 424.2 441.4 11794.5 14468.8 20516.6 20805.9 21278.4 21349.9 21544.2 22165.9 22486.0 22826.5 5924.2 6766.7 6811.8 6983.2 6987.6 4208.8 4510.3 6834.6 6957.8 6958.3 4480.0 7969.5 8010.6 8010.9 8018.0 7813.8 7956.0 7961.8 7998.4 8051.1 7512.8 7750.4 7789.1 7801.3 7838.2 27058.7 27129.7 27192.8 27213.5 27476.7 2874.3 2946.6 2956.4 2957.8 3001.4 16001.0 16223.6 16461.3 16567.5 17167.1 1919.5 2008.5 2010.5 2012.2 2037.1 164715.2 166953.0 171441.0 173441.0 174796.0 19767.8 19785.4 19863.2 19967.2 20050.9 31309.8 31428.7 31491.2 31579.7 31598.9 10149.7 10161.2 10287.5 10340.7 10501.7 6953.6 8556.2 8568.2 8740.3 8779.0 8997.0 9126.5 9207.9 9224.0 9225.8 3139.5 3140.6 3449.0 3531.7 3681.8 997.6 1002.6 1004.8 1007.5 1049.3 15968.8 19783.8 19970.9 20036.6 20069.0 974.0 977.3 1011.6 1017.8 1023.9 9922.9 10582.6 10653.5 10710.0 10763.0 622577.0 624127.0 630291.0 675590.0 703188.0 151597.0 152686.0 152805.5 155528.0 158384.2 1159.0 1181.9 1207.5 1210.0 1211.8 17349.9 18020.0 18081.1 18173.0 18488.4 41262.8 60156.0 61010.4 61167.7 62037.4 83976.0 84151.6 84399.6 84748.6 87351.6 10842.6 10893.2 11352.3 11360.7 11632.2 12431.8 12473.4 12736.9 12763.9 12897.5 10501.4 10858.5 10979.5 10997.3 10998.2 7596.8 8474.5 10320.1 10407.1 10496.9 11049.5 11217.5 11327.9 11328.0 11363.9 11031.3 11439.9 11450.1 11459.4 11470.4 10684.3 10721.7 11021.6 11060.9 11235.3 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:6623.04 Median:2349.78 stddev:4194.48 (178.5%) stddev-sans-first:4188.79 07:06:17 INFO - PROCESS | 1653 | Values: 1529.3 1530.3 1555.1 1586.4 1590.9 8502.7 11056.3 11063.5 11070.6 11079.8 9289.6 10472.2 10831.9 10941.2 10959.1 2041.5 2306.3 2317.7 2347.0 2349.6 2197.5 2207.6 2210.2 2210.5 2296.2 2209.2 2213.1 2217.2 2219.1 2330.6 2239.7 2299.9 2307.9 2308.6 2310.4 2319.5 2333.5 2335.3 2339.6 2349.9 10833.9 10915.8 10919.5 10925.8 10933.4 5380.5 5535.7 5536.6 5539.9 5543.1 3128.2 3211.7 3402.3 3410.8 3421.6 1124.6 1139.5 1148.8 1167.5 1176.9 13677.5 13938.8 14244.0 15448.5 15542.0 3772.9 4345.5 4488.1 4494.3 4513.8 11489.0 11507.4 11512.3 11512.4 11515.3 4685.1 4856.5 5315.1 5447.0 5449.1 5016.3 5112.3 5133.0 5137.3 5144.2 3619.4 3683.9 3699.1 3757.0 3760.3 800.6 935.3 937.0 942.2 948.1 921.6 935.6 943.6 946.0 994.8 6517.3 6541.9 6621.3 6784.7 6807.9 1011.1 1033.7 1064.0 1103.5 1105.1 4088.8 4126.1 4153.1 4302.8 4307.0 13718.9 14246.0 14252.4 14274.0 14281.2 12892.1 13329.7 13474.9 13502.1 14030.3 9976.4 10204.2 10229.9 10249.7 10284.6 6386.9 6641.0 6811.5 6818.1 6856.1 12097.6 12227.5 12343.3 12363.5 12364.8 11348.6 11507.1 12298.6 12471.1 12480.1 9175.1 9450.3 9460.1 9485.1 9486.1 10002.0 10174.8 10317.8 10321.5 10342.8 8515.4 8718.0 8741.0 8810.7 9109.2 8491.8 8496.7 8539.1 8581.6 8609.6 7797.6 7825.6 7884.3 7917.6 7924.0 5762.4 5770.9 5853.5 5931.5 6012.2 5811.4 5936.1 5937.3 5970.9 6057.9 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4444.56 Median:4723.30 stddev:1221.78 (25.9%) stddev-sans-first:1186.19 07:06:17 INFO - PROCESS | 1653 | Values: 363.8 372.5 380.4 380.5 383.6 4778.2 4802.6 5089.2 5136.4 5141.7 3810.7 4154.5 4219.9 4633.5 4929.7 3489.2 3866.7 4152.8 4158.9 4163.6 4033.9 4200.7 4207.9 4209.8 4215.6 3309.5 3408.7 4196.4 4197.6 4203.3 3654.7 4103.3 4103.9 4127.2 4157.2 3445.1 3664.5 3801.6 3811.3 3839.4 3956.4 4049.9 4095.7 4546.0 4892.4 3607.7 4653.9 4834.6 4844.7 4861.0 5350.4 5376.9 5382.4 5442.3 5444.3 3903.7 4236.6 4546.0 4692.4 4698.2 4549.7 5286.9 5560.7 5656.3 5689.9 4222.4 4541.7 4590.5 4605.4 4607.9 3827.8 4055.9 4692.8 4723.7 4749.5 4494.0 4713.7 4722.9 4900.8 4947.5 4299.8 4380.9 4939.4 5338.0 5341.9 1655.0 1665.7 1667.9 1679.3 1696.6 1151.3 1267.4 1326.1 1364.4 1394.9 4496.9 4650.5 4892.9 4954.7 4965.8 4713.5 5123.5 5291.1 5433.8 5458.0 3952.7 4392.0 4414.8 4482.0 4926.0 2451.2 2626.5 2667.8 2789.5 2817.7 5213.0 5556.3 5786.6 5793.7 5795.9 4605.4 4897.6 5360.6 5674.0 5787.5 5241.7 5256.0 5506.0 5651.7 5822.3 4604.4 4783.5 5394.9 5574.9 5610.3 5211.9 5231.7 5498.0 5524.0 5546.4 4894.2 5071.6 5338.4 5457.3 5824.8 4252.1 4252.4 4403.5 4427.6 4433.2 4950.6 5383.0 5553.8 5589.2 5603.9 5365.0 5387.9 5392.4 5403.8 5434.7 4561.2 4602.6 4757.0 4844.1 5413.0 5241.9 5263.3 5268.9 5282.9 5289.8 4625.7 5178.7 5410.6 5422.8 5440.4 4806.2 5094.9 5146.2 5209.2 5287.6 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:19944.53 Median:3518.60 stddev:28899.22 (821.3%) stddev-sans-first:28944.21 07:06:17 INFO - PROCESS | 1653 | Values: 713.0 744.2 757.6 822.5 824.7 15127.8 15763.3 15896.4 16009.6 16074.0 14290.9 16417.3 17210.5 17402.3 17571.3 924.9 955.6 958.5 960.4 960.9 919.6 940.5 953.0 955.2 957.0 1002.9 1006.7 1007.1 1008.0 1008.4 993.9 997.5 998.5 998.6 999.7 740.8 741.0 741.7 742.6 743.2 15532.3 15995.6 16014.5 16195.3 16471.0 12728.6 12747.9 13045.6 13046.0 13305.3 11469.2 11571.3 11768.0 12209.0 12305.4 3540.7 3576.9 3647.2 3658.9 3735.9 116206.0 117280.4 118035.0 119572.4 121579.4 9166.5 10359.7 10699.1 10957.6 11298.8 21545.6 21572.8 21630.1 21827.6 21963.3 7536.2 7589.7 7743.3 8003.0 8019.9 4268.7 4319.1 4323.8 4419.6 4511.6 3420.0 3478.1 3495.5 3516.1 3521.2 552.6 611.8 615.0 617.3 624.0 629.2 663.7 692.2 693.0 725.7 9594.2 10146.8 10200.9 10258.9 10446.2 638.3 705.2 716.7 719.0 723.4 4696.6 4943.6 4945.2 4953.3 4960.3 77160.6 104029.5 104746.0 105567.5 106902.0 57641.1 58697.7 66972.0 68686.0 90045.5 75545.5 76076.0 76746.0 78026.6 79279.0 10802.6 10963.0 11025.4 11167.4 11181.6 32348.0 44528.7 47662.3 48426.8 48776.5 59086.4 64925.7 65355.0 66932.3 66983.7 11819.6 11919.8 12321.6 12797.7 12824.7 13441.8 14586.5 14683.6 14747.8 15210.5 11869.8 12900.6 13431.6 13625.9 13803.0 12938.4 13664.0 13773.9 13783.0 13920.4 12445.0 13623.8 13744.7 13903.7 13929.7 9038.3 9343.3 9491.2 9504.0 9855.7 8383.7 10232.9 11076.4 11175.2 11577.2 07:06:17 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:06:17 INFO - PROCESS | 1653 | 07:06:17 INFO - TEST-INFO | 1653: exit 0 07:06:17 INFO - TEST-OK | dromaeo_css | took 1120706ms 07:06:17 INFO - TEST-START | kraken 07:06:17 INFO - operating with platform_type : mac_ 07:06:17 INFO - Initialising browser for kraken test... 07:06:17 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmprEcnXz/profile http://localhost:49241/getInfo.html) 07:06:20 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 07:06:20 INFO - PROCESS | 1658 | colorDepth:24 07:06:20 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 07:06:20 INFO - PROCESS | 1658 | __metrics 07:06:20 INFO - PROCESS | 1658 | 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" 07:06:20 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:20 INFO - TEST-INFO | 1658: exit 0 07:06:20 INFO - Browser initialized. 07:06:20 INFO - Running cycle 1/1 for kraken test... 07:06:20 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmprEcnXz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:33 INFO - PROCESS | 1659 | RSS: Main: 215248896 07:06:33 INFO - PROCESS | 1659 | 07:06:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:06:36 INFO - PROCESS | 1659 | RSS: Main: 267411456 07:06:36 INFO - PROCESS | 1659 | 07:06:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:06:40 INFO - PROCESS | 1659 | RSS: Main: 278929408 07:06:40 INFO - PROCESS | 1659 | 07:06:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:06:44 INFO - PROCESS | 1659 | RSS: Main: 375668736 07:06:44 INFO - PROCESS | 1659 | 07:06:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:06:46 INFO - PROCESS | 1659 | RSS: Main: 277663744 07:06:46 INFO - PROCESS | 1659 | 07:06:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:06:49 INFO - PROCESS | 1659 | RSS: Main: 278859776 07:06:49 INFO - PROCESS | 1659 | 07:06:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:06:52 INFO - PROCESS | 1659 | RSS: Main: 320049152 07:06:52 INFO - PROCESS | 1659 | 07:06:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:06:56 INFO - PROCESS | 1659 | RSS: Main: 319455232 07:06:56 INFO - PROCESS | 1659 | 07:06:59 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:07:00 INFO - PROCESS | 1659 | RSS: Main: 318578688 07:07:00 INFO - PROCESS | 1659 | 07:07:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:02 INFO - PROCESS | 1659 | RSS: Main: 294678528 07:07:02 INFO - PROCESS | 1659 | 07:07:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:04 INFO - PROCESS | 1659 | RSS: Main: 298377216 07:07:04 INFO - PROCESS | 1659 | 07:07:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:07 INFO - PROCESS | 1659 | RSS: Main: 299716608 07:07:07 INFO - PROCESS | 1659 | 07:07:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:11 INFO - PROCESS | 1659 | RSS: Main: 319094784 07:07:11 INFO - PROCESS | 1659 | 07:07:14 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:15 INFO - PROCESS | 1659 | RSS: Main: 312905728 07:07:15 INFO - PROCESS | 1659 | 07:07:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:07:16 INFO - PROCESS | 1659 | RSS: Main: 357949440 07:07:16 INFO - PROCESS | 1659 | 07:07:16 INFO - PROCESS | 1659 | __start_tp_report 07:07:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 07:07:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 07:07:16 INFO - PROCESS | 1659 | |i|pagename|runs| 07:07:16 INFO - PROCESS | 1659 | |0;ai-astar;117;117;117;116;112;111;117;118;117;116 07:07:16 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;109;111;143;110;136;139;138;130;111 07:07:16 INFO - PROCESS | 1659 | |2;audio-dft;206;265;197;189;183;185;185;185;184;185 07:07:17 INFO - PROCESS | 1659 | |3;audio-fft;83;62;60;95;63;62;60;60;78;64 07:07:17 INFO - PROCESS | 1659 | |4;audio-oscillator;88;69;87;70;69;67;83;68;68;84 07:07:17 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;90;89;89;90;118;132;89;89;89;89 07:07:17 INFO - PROCESS | 1659 | |6;imaging-darkroom;96;96;97;96;96;101;134;97;96;95 07:07:17 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;83;85;83;83;84;84;87;85;82 07:07:17 INFO - PROCESS | 1659 | |8;json-parse-financial;61;60;59;63;64;64;64;66;63;64 07:07:17 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;53;59;58;64;60;57;57;57;56;56 07:07:17 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;96;101;82;83;85;85;83;82;82;84 07:07:17 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;139;139;137;137;139;145;148;149;180;138 07:07:17 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;163;156;205;225;161;212;221;168;167;167 07:07:17 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;66;65;68;65;66;65;64;66;64;64 07:07:17 INFO - PROCESS | 1659 | __end_tp_report 07:07:17 INFO - PROCESS | 1659 | __start_cc_report 07:07:17 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2150 07:07:17 INFO - PROCESS | 1659 | __end_cc_report 07:07:17 INFO - PROCESS | 1659 | __startTimestamp1490882836996__endTimestamp 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | ------- Summary: start ------- 07:07:17 INFO - PROCESS | 1659 | Number of tests: 14 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:2.35 (2.0%) stddev-sans-first:2.45 07:07:17 INFO - PROCESS | 1659 | Values: 117.0 117.0 117.0 116.0 112.0 111.0 117.0 118.0 117.0 116.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:137.00 stddev:14.88 (10.9%) stddev-sans-first:14.61 07:07:17 INFO - PROCESS | 1659 | Values: 143.0 109.0 111.0 143.0 110.0 136.0 139.0 138.0 130.0 111.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:196.40 Median:187.00 stddev:25.18 (13.5%) stddev-sans-first:26.47 07:07:17 INFO - PROCESS | 1659 | Values: 206.0 265.0 197.0 189.0 183.0 185.0 185.0 185.0 184.0 185.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:68.70 Median:63.50 stddev:12.27 (19.3%) stddev-sans-first:11.87 07:07:17 INFO - PROCESS | 1659 | Values: 83.0 62.0 60.0 95.0 63.0 62.0 60.0 60.0 78.0 64.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:8.92 (11.7%) stddev-sans-first:8.19 07:07:17 INFO - PROCESS | 1659 | Values: 88.0 69.0 87.0 70.0 69.0 67.0 83.0 68.0 68.0 84.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:89.00 stddev:15.44 (17.3%) stddev-sans-first:16.20 07:07:17 INFO - PROCESS | 1659 | Values: 90.0 89.0 89.0 90.0 118.0 132.0 89.0 89.0 89.0 89.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:100.40 Median:96.00 stddev:11.92 (12.4%) stddev-sans-first:12.53 07:07:17 INFO - PROCESS | 1659 | Values: 96.0 96.0 97.0 96.0 96.0 101.0 134.0 97.0 96.0 95.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.41 (1.7%) stddev-sans-first:1.50 07:07:17 INFO - PROCESS | 1659 | Values: 84.0 83.0 85.0 83.0 83.0 84.0 84.0 87.0 85.0 82.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:64.00 stddev:2.15 (3.4%) stddev-sans-first:2.18 07:07:17 INFO - PROCESS | 1659 | Values: 61.0 60.0 59.0 63.0 64.0 64.0 64.0 66.0 63.0 64.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:57.50 stddev:2.91 (5.1%) stddev-sans-first:2.54 07:07:17 INFO - PROCESS | 1659 | Values: 53.0 59.0 58.0 64.0 60.0 57.0 57.0 57.0 56.0 56.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:83.50 stddev:6.63 (7.9%) stddev-sans-first:6.04 07:07:17 INFO - PROCESS | 1659 | Values: 96.0 101.0 82.0 83.0 85.0 85.0 83.0 82.0 82.0 84.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:142.00 stddev:13.06 (9.2%) stddev-sans-first:13.66 07:07:17 INFO - PROCESS | 1659 | Values: 139.0 139.0 137.0 137.0 139.0 145.0 148.0 149.0 180.0 138.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:186.50 stddev:27.61 (14.8%) stddev-sans-first:28.17 07:07:17 INFO - PROCESS | 1659 | Values: 163.0 156.0 205.0 225.0 161.0 212.0 221.0 168.0 167.0 167.0 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 07:07:17 INFO - PROCESS | 1659 | Values: 66.0 65.0 68.0 65.0 66.0 65.0 64.0 66.0 64.0 64.0 07:07:17 INFO - PROCESS | 1659 | -------- Summary: end -------- 07:07:17 INFO - PROCESS | 1659 | 07:07:17 INFO - TEST-INFO | 1659: exit 0 07:07:17 INFO - TEST-OK | kraken | took 60255ms 07:07:17 INFO - SUITE-END | took 1180s 07:07:18 INFO - Completed test suite (00:19:41) 07:07:18 INFO - javascript benchmark 07:07:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7520.923594249782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.729541636669, 3381.374445727539, 3387.1362802485364, 3388.7966721996677, 3427.4687423449373, 4685.554872287135, 5769.682667453289, 5778.7977420790285, 5838.211841401415, 5851.736671849766, 5760.423957604237, 5829.446202610745, 5848.4736373726355, 5856.736446859891, 5859.121131830228, 5235.581153507729, 5275.446078161795, 5279.445658205891, 5320.600954928376, 5365.651232669864, 5167.948320516784, 5188.766505507261, 5353.625246232766, 5389.622726409153, 5389.622726409153, 5237.004969055886, 5270.5520030797425, 5291.735413229342, 5296.788128474856, 5298.92051619226, 5269.789208431658, 5290.603204759658, 5291.629585928987, 5301.575873930076, 5311.814086506954, 5152.92270615941, 5236.0, 5260.316158899357, 5262.60530460217, 5277.419483856773, 5780.306363236438, 5781.942180578182, 5789.797357092523, 5790.942090579082, 5791.913121303184, 6167.259928808572, 6180.165677633507, 6182.1345011698395, 6182.443580077815, 6183.505319574423, 6266.530010249249, 6266.811995640138, 6277.089821975834, 6284.0, 6323.36766323364, 5877.9118313225335, 5914.9112763308585, 5927.703614819242, 5931.080682494177, 5967.6419414835245, 6238.095476155932, 6324.778632747832, 6368.14030105939, 6378.138951241569, 6382.968085159591, 6134.589663226396, 6139.597154504007, 6197.225346831646, 6204.410580994889, 6267.62394256346, 6334.746610135635, 6352.872942541123, 6361.713722882481, 6364.77723279683, 6380.330065343165, 6357.396047375492, 6365.61806291624, 6376.458001069961, 6390.584612000205, 6390.680465976682, 6048.0625503047095, 6155.384461553809, 6291.213598300213, 6353.364663533702, 6399.488040956712, 4478.664100192498, 5016.423111342169, 5062.417821950449, 5070.721110338966, 5094.566961808214, 4529.932051019237, 4537.183307004705, 4537.636989040869, 4545.568171023748, 4574.313852922089, 5889.1755154278435, 5935.139404786281, 5939.524838013035, 5947.107933809876, 5953.0, 6194.163787888668, 6202.131701561785, 6295.716692748837, 6323.177986861679, 6338.334474880164, 5883.0881213411985, 5888.0, 5953.940460595425, 5955.076963070731, 5983.132445795335, 4690.484046754854, 5544.61187716856, 5548.0845660466375, 5554.944450555524, 5557.249771280906, 6221.222347206599, 6409.7115629795835, 6416.390442907917, 6455.935440645628, 6465.321141280286, 5179.22311653255, 6308.495320374451, 6314.905276420949, 6318.684065796784, 6319.3364696706185, 6293.590916590407, 6299.622022678654, 6329.8734025320155, 6331.2085989251345, 6335.588186767845, 6332.715027823667, 6354.745810167727, 6359.8092057238355, 6377.553571249968, 6404.423601875854, 6303.1175635412, 6326.4622507087415, 6343.429091381798, 6344.111824344688, 6362.840928976812, 6047.909281360695, 6094.268687757498, 6195.690215489298, 6219.657918814328, 6305.0, 5095.363079615048, 6258.874822503433, 6260.561760676709, 6286.0, 6288.937110628835, 6117.632942023492, 6122.173506576555, 6127.20346354971, 6133.478654314434, 6135.325114237341, 6005.0, 6023.27720673522, 6301.558890877594, 6330.177076979963, 6346.428821405911, 5952.970235148797, 6007.87984240304, 6101.145839582551, 6119.326874043941, 6139.6009259398], "value": 5776.468403898098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.5359132585504, 715.3311653603878, 788.6805843633327, 856.91859273369, 868.617808164408, 27136.0, 39197.608023919754, 39610.80194599023, 39635.405468917954, 39959.0, 39809.805705828796, 39995.60004399955, 40035.59964400355, 40067.398989015186, 40156.79921600395, 7329.303716146984, 9006.45961242326, 9106.13491718289, 9133.771655708593, 9137.40606860552, 7455.440841936849, 10931.289466184673, 11081.113510919147, 11170.0, 11173.497192626312, 11001.22991390603, 11037.724056898562, 11047.116230701524, 11055.0, 11094.55621775128, 7214.603196824172, 10984.06635435989, 11003.61487347947, 11014.39420831858, 11018.669439916815, 7246.96376518114, 10574.735631609194, 10822.404767737771, 10897.182711296684, 10922.672319830417, 38132.61867381319, 38159.855204343636, 38180.0, 38199.427008594896, 38299.0, 3741.307858046243, 3766.9058273543105, 3781.300459415017, 3798.126430920876, 3879.7478163919254, 26529.071482498213, 26621.06826261091, 26904.327391815164, 26976.325591860164, 27939.88240470379, 3025.833579153146, 3083.8766449342, 3099.02380750063, 3152.4640811061945, 3158.6683398243313, 326122.0, 326484.0, 326665.3666731651, 326683.0, 327043.36478317453, 50464.990700185794, 50556.49443505518, 50585.747071264406, 50673.49326506688, 50729.492705073215, 52328.73835630798, 52331.0, 52347.73826130921, 52382.69043273949, 52516.94966100733, 14390.784138237936, 14529.692327690558, 14535.927320363542, 14558.708825823423, 14562.635934101732, 10925.125989920787, 11036.227464077438, 12532.436040378205, 12540.81188782169, 12548.24710517372, 10641.680749577525, 11849.466773995191, 11928.403579820973, 12179.817302740466, 12315.322657253937, 5281.0758117329315, 5300.602454815904, 5300.734963251822, 5308.708021058879, 5320.334958130234, 978.2272005115879, 1138.5218208352512, 1141.7773534160924, 1144.1476100305326, 1144.3991904250336, 24733.010679572617, 25729.22812315596, 26178.08376706806, 26660.866695666784, 26757.331066723487, 850.2452055340775, 1075.989240107589, 1124.454639499842, 1132.6205721083365, 1169.4094482286391, 11108.61119860801, 12700.80948785769, 12878.034147438979, 12953.287569183596, 12972.80540791889, 322130.0, 324006.0, 324053.37973310455, 325005.0, 325130.0, 51280.743596281776, 51480.22779658308, 51487.0, 51557.74221128871, 51875.48124518782, 1423.6973169549954, 1465.3113036872653, 1479.7484427647325, 1480.3930388540646, 1481.9555413337616, 21198.682019769407, 23500.0, 24706.0, 24863.87568062148, 27081.912706747487, 44798.552014480745, 45037.32444013277, 45121.0, 45165.322520161564, 45187.77406112949, 455511.0, 458437.0, 459043.0, 460240.0, 460276.0, 28855.845766169117, 29022.839086436306, 29028.564571531868, 29035.854820725763, 29050.564241535973, 36820.0, 37455.81272093622, 37770.0, 37805.62194378021, 37826.810865946594, 25741.485170296863, 27012.0, 27217.183484495497, 27948.0, 28016.159515214575, 22017.779822201574, 26009.21972340833, 26676.199714007835, 26766.19701408961, 27211.455770884866, 30615.928442504406, 30951.0, 31455.0, 31513.0, 31541.0, 25295.620565691162, 25569.872150639127, 26667.466650667266, 26921.326966825985, 27240.580173413062, 21238.36284911455, 22255.888720556293, 22278.0, 23501.529969400857, 24146.51706965886], "value": 17745.212984162215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.78781670081446, 406.81489922085456, 416.34425779397446, 424.22578793701496, 441.4151249594286, 11794.469248883799, 14468.782968255471, 20516.589668206627, 20805.895970520163, 21278.361649150513, 21349.893250533725, 21544.245951391706, 22165.891705414706, 22486.0, 22826.543469130607, 5924.200232968537, 6766.729330826761, 6811.795646130624, 6983.16202055754, 6987.580745155307, 4208.831646734127, 4510.345999830022, 6834.589924604539, 6957.756478523227, 6958.304169583026, 4480.0, 7969.521828690297, 8010.5594192319395, 8010.919890801105, 8017.95991020047, 7813.843723125534, 7956.005499312586, 7961.800954976114, 7998.36013118952, 8051.074126475413, 7512.812179695551, 7750.418718596128, 7789.143194248628, 7801.29788319054, 7838.216178382173, 27058.72941270582, 27129.728702712917, 27192.824574034028, 27213.45573088547, 27476.725232747816, 2874.2814296425895, 2946.616939797834, 2956.4382767274365, 2957.8225306481463, 3001.429728351628, 16001.0, 16223.594410139724, 16461.25924333408, 16567.50297491077, 17167.141642917803, 1919.4721451600783, 2008.4978755311172, 2010.5174758058106, 2012.164951545107, 2037.0833125093618, 164715.1764241183, 166953.0, 171441.0, 173441.0, 174796.0, 19767.813931164175, 19785.40643780689, 19863.205471781257, 19967.20131194765, 20050.899745501178, 31309.8434507826, 31428.685713143033, 31491.212719681735, 31579.684203158133, 31598.894038708535, 10149.746256343502, 10161.237907156992, 10287.537060832281, 10340.689779306633, 10501.737456563647, 6953.582785032813, 8556.229939305493, 8568.186022327869, 8740.257078148301, 8778.95610521956, 8997.0, 9126.49804260772, 9207.90792092084, 9224.0, 9225.800645916122, 3139.4662907305815, 3140.638826534932, 3448.965110584767, 3531.7168261293114, 3681.7790932544135, 997.5660587644398, 1002.5989604158249, 1004.8090862736057, 1007.4610083605236, 1049.302214027663, 15968.76046859298, 19783.802161978485, 19970.90014549918, 20036.599268014557, 20069.0, 973.9951300243454, 977.3207620703542, 1011.630754774502, 1017.7913527726798, 1023.8924912884189, 9922.900770992197, 10582.576696932036, 10653.520591573399, 10710.0, 10763.0, 622577.0, 624127.0, 630291.0, 675590.0, 703188.0, 151597.0, 152686.0, 152805.47194527913, 155528.0, 158384.20807895888, 1159.0176038549644, 1181.8877206665354, 1207.5169932027084, 1210.0440651885087, 1211.8485189351507, 17349.913250434172, 18020.0, 18081.095945202425, 18173.0, 18488.35290764817, 41262.79368603138, 60156.0, 61010.389896100474, 61167.69416152891, 62037.37962620316, 83976.0, 84151.57924210584, 84399.5780021096, 84748.57625711831, 87351.56324218339, 10842.566297348334, 10893.183011274345, 11352.318860868374, 11360.715982100513, 11632.18574699763, 12431.75136497247, 12473.376331183223, 12736.87263127394, 12763.87236127664, 12897.548585799452, 10501.369917804956, 10858.457077145953, 10979.451027448436, 10997.285176463503, 10998.230123891572, 7596.8480630388185, 8474.491530508189, 10320.12278956297, 10407.115395191191, 10496.947515262375, 11049.5027723751, 11217.495212715285, 11327.943360283145, 11328.0, 11363.886361136614, 11031.282966607145, 11439.885601143882, 11450.141239406912, 11459.4270286487, 11470.4264786762, 10684.252102353072, 10721.731956701145, 11021.61424350176, 11060.889391105986, 11235.325880446871], "value": 11348.688746228685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.2583097197864, 1530.3496014193965, 1555.1213564336142, 1586.4288856011833, 1590.9443169489066, 8502.702405415805, 11056.336619802818, 11063.502142403591, 11070.612528561502, 11079.833802492969, 9289.581968811402, 10472.16222702184, 10831.945840270788, 10941.23411361205, 10959.12327013839, 2041.4998325410295, 2306.3426923326856, 2317.6523521471745, 2347.0494449747794, 2349.635806450003, 2197.494576247464, 2207.5915955548194, 2210.18223257395, 2210.546837898227, 2296.1848543766973, 2209.193644319828, 2213.0594497338648, 2217.1796435318956, 2219.1234462387347, 2330.5571941331177, 2239.675247089163, 2299.908003679851, 2307.861528308307, 2308.595995700754, 2310.3761984264156, 2319.4665226997886, 2333.4516388648653, 2335.311083230451, 2339.5671800716923, 2349.917752878658, 10833.891661083368, 10915.781684366268, 10919.508622112024, 10925.781484370347, 10933.398663073527, 5380.542653874425, 5535.667859928377, 5536.612437129403, 5539.944600553983, 5543.113101903676, 3128.1866714654125, 3211.678832116793, 3402.2515046689687, 3410.84651190697, 3421.623621401644, 1124.5614210457927, 1139.481535901163, 1148.7759886822073, 1167.4512978899904, 1176.941152942358, 13677.452901883913, 13938.790918136236, 14244.00291979562, 15448.536543903701, 15541.98977066487, 3772.867949621805, 4345.543717909574, 4488.079943611552, 4494.303382975579, 4513.75174365413, 11489.0, 11507.367094809699, 11512.251703639236, 11512.366819824823, 11515.30908145514, 4685.1332503486965, 4856.514348565186, 5315.069862773999, 5446.972765136228, 5449.073657478239, 5016.322796422436, 5112.258722485219, 5133.0, 5137.332146820964, 5144.176931690911, 3619.4208926571623, 3683.9447408288897, 3699.093722038118, 3757.0231739747865, 3760.304343696425, 800.5956991719145, 935.2611436964858, 936.9672061477816, 942.2038377570941, 948.0661548374845, 921.5760750054916, 935.5976929920199, 943.613118621362, 946.0, 994.8457989011715, 6517.348265173445, 6541.8691626168165, 6621.304762999912, 6784.660766961632, 6807.863842723118, 1011.1354791653177, 1033.6950599573145, 1063.9893601064045, 1103.5254840418536, 1105.0883021507289, 4088.836446542105, 4126.133511962522, 4153.127843152912, 4302.784860757012, 4306.978465107654, 13718.93140534291, 14246.002779805314, 14252.429902803771, 14274.0, 14281.214533200566, 12892.097553171188, 13329.66675833112, 13474.865251347557, 13502.122362046435, 14030.298485075706, 9976.401415915068, 10204.183665306906, 10229.897701023043, 10249.743756406, 10284.6115774371, 6386.9361306386345, 6641.0, 6811.489138314745, 6818.113645226089, 6856.108705868404, 12097.57658481949, 12227.510899563918, 12343.259404435763, 12363.505459781509, 12364.814527781911, 11348.602798901999, 11507.136964727511, 12298.569550065704, 12471.127021108436, 12480.126391152895, 9175.08249175077, 9450.291228157777, 9460.101290377403, 9485.146336829719, 9486.098820612031, 10002.0, 10174.796504070026, 10317.845232321371, 10321.535530900977, 10342.844857326996, 8515.361347898808, 8718.041015488418, 8740.956295218482, 8810.735677929672, 9109.22571581423, 8491.78770530717, 8496.660133594834, 8539.103394143525, 8581.613827377658, 8609.569521523774, 7797.649105790139, 7825.569593672402, 7884.29041386278, 7917.564533950688, 7924.009498812648, 5762.423757624371, 5770.913436298375, 5853.531717462678, 5931.466168044896, 6012.188354572252, 5811.4479124483105, 5936.13925980739, 5937.2578427696535, 5970.940290597212, 6057.879292330933], "value": 5018.373596304823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.7999100494727, 372.4952689106261, 380.43695330910253, 380.528145100076, 383.62213219978315, 4778.208171935528, 4802.59177969873, 5089.208539637965, 5136.4093129290095, 5141.742912854361, 3810.676092532131, 4154.543000269976, 4219.894502637436, 4633.513481084488, 4929.679570827893, 3489.1681867019765, 3866.6520013198806, 4152.750834949898, 4158.9376159357635, 4163.625273725356, 4033.899152521181, 4200.663946884257, 4207.948012996751, 4209.768462734548, 4215.641670458015, 3309.4776402854714, 3408.7102596279346, 4196.433481480007, 4197.643200327976, 4203.30645443503, 3654.7258955578304, 4103.343465045608, 4103.876883693494, 4127.236461254647, 4157.230912281222, 3445.104272889042, 3664.468652045465, 3801.5818259991656, 3811.313963486571, 3839.4240863870364, 3956.40653901917, 4049.906525238199, 4095.7268715862683, 4545.977270113662, 4892.412910450768, 3607.7113830893463, 4653.859804347956, 4834.58905992991, 4844.66087373884, 4861.003494283698, 5350.438203988564, 5376.865578360533, 5382.3541175059245, 5442.292501974757, 5444.265024221759, 3903.726739128262, 4236.597523235288, 4545.999880026389, 4692.389989301369, 4698.248280275139, 4549.727016379028, 5286.947130528684, 5560.749766260487, 5656.349519805234, 5689.943100568983, 4222.366645003212, 4541.6593755468475, 4590.540945905383, 4605.443978591914, 4607.884802879955, 3827.8468861245237, 4055.9391609125887, 4692.788824502905, 4723.716577005391, 4749.548792864673, 4493.977710030499, 4713.740744259098, 4722.881927951828, 4900.779464924087, 4947.529984651453, 4299.763513006752, 4380.934285985712, 4939.357883475197, 5338.008961620897, 5341.919871201935, 1655.0470444874923, 1665.7340421279914, 1667.9317646118725, 1679.3030892179852, 1696.6437048220012, 1151.332227308176, 1267.4233223883111, 1326.0717497751612, 1364.3519328319167, 1394.9442022318995, 4496.9325460118125, 4650.51169627191, 4892.926606100911, 4954.677945933575, 4965.751712414365, 4713.457952335457, 5123.538881500608, 5291.148098165688, 5433.809816656398, 5458.0, 3952.73105046549, 4391.978040109779, 4414.761828644538, 4481.977590112094, 4926.0, 2451.240115564181, 2626.487834872182, 2667.7599016088643, 2789.4839454700946, 2817.6892151721645, 5213.0, 5556.3050571370395, 5786.582287339545, 5793.740441227925, 5795.88408231833, 4605.447346318463, 4897.632677549198, 5360.5960215263585, 5674.0, 5787.479126878601, 5241.711705856214, 5256.0, 5506.0, 5651.745671444794, 5822.272215973004, 4604.441602813257, 4783.497732738151, 5394.919076213781, 5574.857154283443, 5610.298712660918, 5211.869703257449, 5231.686098834082, 5497.972510137423, 5524.038966166953, 5546.389897111234, 4894.241392584155, 5071.568916641979, 5338.439463856239, 5457.345118585795, 5824.835032993334, 4252.064545799919, 4252.447181866338, 4403.512015711113, 4427.601515863587, 4433.224185767543, 4950.554450099508, 5383.0, 5553.805616803393, 5589.161625756169, 5603.870529198878, 5364.953834002332, 5387.86530336729, 5392.357744705145, 5403.837884863303, 5434.673919564839, 4561.201789686858, 4602.631789456902, 4756.9524304756505, 4844.079624871263, 5412.995787338065, 5241.947580524298, 5263.289455923555, 5268.894622107613, 5282.920756188583, 5289.7619607117, 4625.6530760192445, 5178.663386879992, 5410.594205434687, 5422.755975981169, 5440.428754980829, 4806.221697971773, 5094.898102038012, 5146.202338637517, 5209.218617207449, 5287.629865909504], "value": 4106.587754283591, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.9572225666457, 744.2111361956323, 757.594686842539, 822.4571782623468, 824.6824972385631, 15127.848721512795, 15763.290651920663, 15896.443624473146, 16009.599760006005, 16074.0, 14290.857091429083, 16417.343306267736, 17210.483685489424, 17402.303907843703, 17571.297148114092, 924.8751418558476, 955.6464108279912, 958.4632605740773, 960.3805545423198, 960.8750862387915, 919.6459363145203, 940.4968341937065, 953.0374321934861, 955.2310390135938, 956.9665061722841, 1002.9498525073753, 1006.7483129217695, 1007.1338648762095, 1007.9647212347569, 1008.3848852200152, 993.9055789699967, 997.4663554998041, 998.5456617239175, 998.6155330197854, 999.6601155607092, 740.829609189884, 741.0403527431935, 741.7144399406213, 742.5544673196039, 743.2121950732242, 15532.301046452936, 15995.600109997227, 16014.519564413085, 16195.271212795453, 16471.0, 12728.61814145577, 12747.936260318638, 13045.608631741063, 13046.0, 13305.334733263395, 11469.197156199069, 11571.299993535617, 11768.0, 12209.023278137727, 12305.44625491855, 3540.698051866994, 3576.8926932192076, 3647.2340808430263, 3658.926821463556, 3735.9439608405896, 116206.0, 117280.41359793232, 118035.0, 119572.40213798963, 121579.35261942155, 9166.450012999241, 10359.689209323733, 10699.090577300862, 10957.616483423042, 11298.830517542243, 21545.569088618453, 21572.784272157078, 21630.134794608355, 21827.563448731253, 21963.341099767033, 7536.171021187665, 7589.696412143563, 7743.341815945595, 8002.9599852000365, 8019.879701804478, 4268.658507319407, 4319.114581510783, 4323.783810809447, 4419.558044195554, 4511.593956543861, 3419.965800341965, 3478.095695119287, 3495.4582039783872, 3516.0506663201304, 3521.1549228185563, 552.6407834907343, 611.7950486586955, 615.0374663651461, 617.2901163661825, 624.0452108274347, 629.196507114494, 663.741140955028, 692.2074225012333, 692.9792106236821, 725.6553137259759, 9594.154792342651, 10146.847797283046, 10200.918112536032, 10258.948705256425, 10446.164306855433, 638.3393188050345, 705.1714235773048, 716.6631683108931, 719.0400814912047, 723.4429489293215, 4696.553827386393, 4943.5797957174045, 4945.159322915113, 4953.281774142729, 4960.280759289883, 77160.61419692865, 104029.47985260026, 104746.0, 105567.47216263869, 106902.0, 57641.13538296929, 58697.70651146717, 66972.0, 68686.0, 90045.4977251148, 75545.48909021789, 76076.0, 76746.0, 78026.60986695143, 79279.0, 10802.567897284021, 10962.958518940688, 11025.393603351893, 11167.38579378142, 11181.608643697431, 32348.0, 44528.66414007585, 47662.28506572473, 48426.75786621044, 48776.5122348772, 59086.40913590809, 64925.67537162284, 65355.019674705865, 66932.33067669261, 66983.66508167428, 11819.645410637695, 11919.761604767682, 12321.630351089481, 12797.744045119232, 12824.679383015125, 13441.798373024218, 14586.4894728684, 14683.55949321522, 14747.778783318045, 15210.543683689508, 11869.762604747684, 12900.612981610566, 13431.597052088453, 13625.931870340584, 13803.0, 12938.417771200131, 13663.9752018601, 13773.862261377259, 13783.035187536776, 13920.373583188579, 12445.026853699486, 13623.79564306556, 13744.725105498033, 13903.721925561635, 13929.651758706113, 9038.32212584072, 9343.252539796664, 9491.193248573949, 9503.952480237554, 9855.655052073143, 8383.706570270011, 10232.948835255776, 11076.446177690923, 11175.21773475849, 11577.189596728149], "value": 7548.3561384371405, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 112.0, 111.0, 117.0, 118.0, 117.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 111.0, 143.0, 110.0, 136.0, 139.0, 138.0, 130.0, 111.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 265.0, 197.0, 189.0, 183.0, 185.0, 185.0, 185.0, 184.0, 185.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 60.0, 95.0, 63.0, 62.0, 60.0, 60.0, 78.0, 64.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 87.0, 70.0, 69.0, 67.0, 83.0, 68.0, 68.0, 84.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 90.0, 118.0, 132.0, 89.0, 89.0, 89.0, 89.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 101.0, 134.0, 97.0, 96.0, 95.0], "value": 100.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 83.0, 84.0, 84.0, 87.0, 85.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 63.0, 64.0, 64.0, 64.0, 66.0, 63.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 58.0, 64.0, 60.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 101.0, 82.0, 83.0, 85.0, 85.0, 83.0, 82.0, 82.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 137.0, 137.0, 139.0, 145.0, 148.0, 149.0, 180.0, 138.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 156.0, 205.0, 225.0, 161.0, 212.0, 221.0, 168.0, 167.0, 167.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 65.0, 66.0, 65.0, 64.0, 66.0, 64.0, 64.0], "value": 65.3, "unit": "score"}]}]} 07:07:18 INFO - Return code: 0 07:07:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:07:18 ERROR - # TBPL SUCCESS # 07:07:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:07:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:07:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:07:18 INFO - 2017-03-30 07:07:18.355 screenresolution[1663:12159] starting screenresolution argv=screenresolution get 07:07:18 INFO - 2017-03-30 07:07:18.358 screenresolution[1663:12159] Display 0: 1600x1200x32@60 07:07:18 INFO - 2017-03-30 07:07:18.364 screenresolution[1664:12162] starting screenresolution argv=screenresolution list 07:07:18 INFO - Available Modes on Display 0 07:07:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:07:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:07:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:07:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:07:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:07:18 INFO - Intel Iris: 07:07:18 INFO - Chipset Model: Intel Iris 07:07:18 INFO - Type: GPU 07:07:18 INFO - Bus: Built-In 07:07:18 INFO - VRAM (Dynamic, Max): 1536 MB 07:07:18 INFO - Vendor: Intel (0x8086) 07:07:18 INFO - Device ID: 0x0a2e 07:07:18 INFO - Revision ID: 0x0009 07:07:18 INFO - Displays: 07:07:18 INFO - Display: 07:07:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:07:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:07:18 INFO - Display Serial Number: 1600x1200 60 07:07:18 INFO - Main Display: Yes 07:07:18 INFO - Mirror: Off 07:07:18 INFO - Online: Yes 07:07:18 INFO - Rotation: Supported 07:07:18 INFO - Return code: 0 07:07:18 INFO - Running post-action listener: _resource_record_post_action 07:07:18 INFO - [mozharness: 2017-03-30 14:07:18.598876Z] Finished run-tests step (success) 07:07:18 INFO - Running post-run listener: _resource_record_post_run 07:07:18 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32553984; Write bytes: 510887936; Read time: 325; Write time: 1574 07:07:18 INFO - TinderboxPrint: CPU usage
54.0% 07:07:18 INFO - TinderboxPrint: I/O read bytes / time
32,553,984 / 325 07:07:18 INFO - TinderboxPrint: I/O write bytes / time
510,887,936 / 1,574 07:07:18 INFO - TinderboxPrint: CPU idle
2,214.6 (46.0%) 07:07:18 INFO - TinderboxPrint: CPU system
964.9 (20.1%) 07:07:18 INFO - TinderboxPrint: CPU user
1,630.2 (33.9%) 07:07:18 INFO - TinderboxPrint: Swap in / out
236,302,336 / 0 07:07:18 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 197011968; Write bytes: 189345792; Read time: 15602; Write time: 419 07:07:18 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31616000; Write bytes: 300171776; Read time: 313; Write time: 1089 07:07:19 INFO - Running post-run listener: _upload_blobber_files 07:07:19 INFO - Blob upload gear active. 07:07:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:07:19 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 07:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:07:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:07:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:07:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:07:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:20 INFO - (blobuploader) - INFO - Done attempting. 07:07:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:07:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:07:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:21 INFO - (blobuploader) - INFO - Done attempting. 07:07:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:07:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:07:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:22 INFO - (blobuploader) - INFO - Done attempting. 07:07:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:07:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:25 INFO - (blobuploader) - INFO - Done attempting. 07:07:25 INFO - (blobuploader) - INFO - Iteration through files over. 07:07:25 INFO - Return code: 0 07:07:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:07:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:07:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9fa1cde6f5f2ec005656c3f3275b36ff14ce8911a0c4b7be161c82cbbb471a6cced7cb7bb964f8262ea398c8ce4403e38efeeda4043aaea883fec703e02c567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd4638205ef6a2556064900f787d5525e6affafed7b093ce3e1e887e601813a55aefdbc566dd17b10715370549dee1c755ab6faf4d229f6ee10d50c100a38306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2eaf5f78019b57fc94fbffe4bf0238e28bb82ac01cc1d2bdda4875dd43f3fd754a457a44fe2ec38e5bac65e9e23af7c2b365de08187699685437c020176b0f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f052da1f84409e8c47d0d9565e5c12b35afbca891c7a575df0cc170342b99a98355e55c19d645c5a28318bdaeaa00c9d0769d57d76a1f7e02951d83cfb606be"} 07:07:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:07:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:07:25 INFO - Contents: 07:07:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9fa1cde6f5f2ec005656c3f3275b36ff14ce8911a0c4b7be161c82cbbb471a6cced7cb7bb964f8262ea398c8ce4403e38efeeda4043aaea883fec703e02c567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd4638205ef6a2556064900f787d5525e6affafed7b093ce3e1e887e601813a55aefdbc566dd17b10715370549dee1c755ab6faf4d229f6ee10d50c100a38306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2eaf5f78019b57fc94fbffe4bf0238e28bb82ac01cc1d2bdda4875dd43f3fd754a457a44fe2ec38e5bac65e9e23af7c2b365de08187699685437c020176b0f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f052da1f84409e8c47d0d9565e5c12b35afbca891c7a575df0cc170342b99a98355e55c19d645c5a28318bdaeaa00c9d0769d57d76a1f7e02951d83cfb606be"} 07:07:25 INFO - Running post-run listener: copy_logs_to_upload_dir 07:07:25 INFO - Copying logs to upload dir... 07:07:25 INFO - mkdir: /builds/slave/test/build/upload/logs 07:07:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.390677 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-30 07:07:24.915842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 07:07:24.919634) ========= 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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9fa1cde6f5f2ec005656c3f3275b36ff14ce8911a0c4b7be161c82cbbb471a6cced7cb7bb964f8262ea398c8ce4403e38efeeda4043aaea883fec703e02c567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd4638205ef6a2556064900f787d5525e6affafed7b093ce3e1e887e601813a55aefdbc566dd17b10715370549dee1c755ab6faf4d229f6ee10d50c100a38306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2eaf5f78019b57fc94fbffe4bf0238e28bb82ac01cc1d2bdda4875dd43f3fd754a457a44fe2ec38e5bac65e9e23af7c2b365de08187699685437c020176b0f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f052da1f84409e8c47d0d9565e5c12b35afbca891c7a575df0cc170342b99a98355e55c19d645c5a28318bdaeaa00c9d0769d57d76a1f7e02951d83cfb606be"} build_url:https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/IPNBdK39QmWYwZT9a7t6wQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9fa1cde6f5f2ec005656c3f3275b36ff14ce8911a0c4b7be161c82cbbb471a6cced7cb7bb964f8262ea398c8ce4403e38efeeda4043aaea883fec703e02c567", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd4638205ef6a2556064900f787d5525e6affafed7b093ce3e1e887e601813a55aefdbc566dd17b10715370549dee1c755ab6faf4d229f6ee10d50c100a38306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2eaf5f78019b57fc94fbffe4bf0238e28bb82ac01cc1d2bdda4875dd43f3fd754a457a44fe2ec38e5bac65e9e23af7c2b365de08187699685437c020176b0f53", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f052da1f84409e8c47d0d9565e5c12b35afbca891c7a575df0cc170342b99a98355e55c19d645c5a28318bdaeaa00c9d0769d57d76a1f7e02951d83cfb606be"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 07:07:24.957710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 07:07:24.958039) ========= 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.t3fi7R31Al/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.RJmaQ4ZXOz/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 07:07:25.005894) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 07:07:25.006195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 07:07:25.006520) ========= ========= Total master_lag: 0.22 =========