builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0297 starttime: 1484667038.72 results: success (0) buildid: 20170117065524 builduid: a840005bf62e4dda82dc989f8c6df3cd revision: 7a4f03169c77e4618312be942f7c5fa17f7bcb68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.717530) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.718048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.718329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.746251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.746655) ========= 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.E5U7H2Q240/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.UfQOgZe3xL/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-17 07:30:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.7M=0.001s 2017-01-17 07:30:38 (19.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.941828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.942142) ========= 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.E5U7H2Q240/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.UfQOgZe3xL/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.029342 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:38.994129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 07:30:38.994572) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a4f03169c77e4618312be942f7c5fa17f7bcb68 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7a4f03169c77e4618312be942f7c5fa17f7bcb68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E5U7H2Q240/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.UfQOgZe3xL/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-17 07:30:39,093 truncating revision to first 12 chars 2017-01-17 07:30:39,093 Setting DEBUG logging. 2017-01-17 07:30:39,093 attempt 1/10 2017-01-17 07:30:39,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a4f03169c77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 07:30:40,599 unpacking tar archive at: mozilla-central-7a4f03169c77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.790435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-17 07:30:40.808464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:40.808788) ========= script_repo_revision: 7a4f03169c77e4618312be942f7c5fa17f7bcb68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:40.809169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:40.809433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 07:30:40.832127) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-17 07:30:40.832540) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E5U7H2Q240/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.UfQOgZe3xL/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:30:41 INFO - MultiFileLogger online at 20170117 07:30:41 in /builds/slave/test 07:30:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:30:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:41 INFO - {'append_to_log': False, 07:30:41 INFO - 'base_work_dir': '/builds/slave/test', 07:30:41 INFO - 'blob_upload_branch': 'Firefox', 07:30:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:41 INFO - 'branch': 'Firefox', 07:30:41 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:41 INFO - 'config_files': ('talos/mac_config.py',), 07:30:41 INFO - 'default_actions': ('clobber', 07:30:41 INFO - 'read-buildbot-config', 07:30:41 INFO - 'download-and-extract', 07:30:41 INFO - 'populate-webroot', 07:30:41 INFO - 'create-virtualenv', 07:30:41 INFO - 'install', 07:30:41 INFO - 'run-tests'), 07:30:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:41 INFO - 'download_minidump_stackwalk': True, 07:30:41 INFO - 'download_symbols': 'ondemand', 07:30:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:41 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:41 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:41 INFO - 'installer_path': 'installer.exe', 07:30:41 INFO - 'log_level': 'info', 07:30:41 INFO - 'log_name': 'talos', 07:30:41 INFO - 'log_to_console': True, 07:30:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:30:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:30:41 INFO - 'opt_config_files': (), 07:30:41 INFO - 'pip_index': False, 07:30:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:41 INFO - 'cmd': ('bash', 07:30:41 INFO - '-c', 07:30:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:41 INFO - 'enabled': True, 07:30:41 INFO - 'halt_on_failure': False, 07:30:41 INFO - 'name': 'check_screen_resolution'},), 07:30:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:41 INFO - 'cmd': ('bash', 07:30:41 INFO - '-c', 07:30:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:41 INFO - 'enabled': True, 07:30:41 INFO - 'halt_on_failure': False, 07:30:41 INFO - 'name': 'check_screen_resolution'},), 07:30:41 INFO - 'run_cmd_checks_enabled': True, 07:30:41 INFO - 'sps_profile': False, 07:30:41 INFO - 'sps_profile_interval': 0, 07:30:41 INFO - 'suite': 'dromaeojs', 07:30:41 INFO - 'system_bits': '32', 07:30:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:41 INFO - 'title': 't-yosemite-r7-0297', 07:30:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:41 INFO - 'use_talos_json': True, 07:30:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:41 INFO - 'work_dir': 'build'} 07:30:41 INFO - [mozharness: 2017-01-17 15:30:41.038428Z] Running clobber step. 07:30:41 INFO - Running pre-action listener: _resource_record_pre_action 07:30:41 INFO - Running main action method: clobber 07:30:41 INFO - rmtree: /builds/slave/test/build 07:30:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:43 INFO - Running post-action listener: _resource_record_post_action 07:30:43 INFO - [mozharness: 2017-01-17 15:30:43.420659Z] Finished clobber step (success) 07:30:43 INFO - [mozharness: 2017-01-17 15:30:43.420941Z] Running read-buildbot-config step. 07:30:43 INFO - Running pre-action listener: _resource_record_pre_action 07:30:43 INFO - Running main action method: read_buildbot_config 07:30:43 INFO - Using buildbot properties: 07:30:43 INFO - { 07:30:43 INFO - "project": "", 07:30:43 INFO - "product": "firefox", 07:30:43 INFO - "script_repo_revision": "production", 07:30:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:30:43 INFO - "repository": "", 07:30:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:30:43 INFO - "buildid": "20170117065524", 07:30:43 INFO - "pgo_build": "False", 07:30:43 INFO - "basedir": "/builds/slave/test", 07:30:43 INFO - "buildnumber": 16, 07:30:43 INFO - "slavename": "t-yosemite-r7-0297", 07:30:43 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:30:43 INFO - "platform": "yosemite_r7", 07:30:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:30:43 INFO - "branch": "mozilla-central", 07:30:43 INFO - "repo_path": "mozilla-central", 07:30:43 INFO - "revision": "7a4f03169c77e4618312be942f7c5fa17f7bcb68", 07:30:43 INFO - "stage_platform": "macosx64", 07:30:43 INFO - "builduid": "a840005bf62e4dda82dc989f8c6df3cd", 07:30:43 INFO - "slavebuilddir": "test" 07:30:43 INFO - } 07:30:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:30:43 INFO - Running post-action listener: _resource_record_post_action 07:30:43 INFO - [mozharness: 2017-01-17 15:30:43.426723Z] Finished read-buildbot-config step (success) 07:30:43 INFO - [mozharness: 2017-01-17 15:30:43.426927Z] Running download-and-extract step. 07:30:43 INFO - Running pre-action listener: _resource_record_pre_action 07:30:43 INFO - Running main action method: download_and_extract 07:30:43 INFO - mkdir: /builds/slave/test/build/tests 07:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:43 INFO - trying https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:30:43 INFO - Downloading https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:30:44 INFO - Downloaded 1199 bytes. 07:30:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:30:44 INFO - Using the following test package requirements: 07:30:44 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:30:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:30:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:30:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'jsshell-mac.zip'], 07:30:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:30:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:30:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:30:44 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:30:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:30:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:44 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:30:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:30:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:30:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:30:44 INFO - Fetch https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:30:45 INFO - Expected file size: 16326588 07:30:45 INFO - Obtained file size: 16326588 07:30:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:30:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:30:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:30:52 INFO - Fetch https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:30:53 INFO - Expected file size: 16326588 07:30:53 INFO - Obtained file size: 16326588 07:30:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:30:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:30:59 INFO - Fetch https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:31:01 INFO - Expected file size: 14403463 07:31:01 INFO - Obtained file size: 14403463 07:31:01 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')]} 07:31:01 INFO - trying https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:31:01 INFO - Downloading https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:31:05 INFO - Downloaded 70113210 bytes. 07:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:31:05 INFO - mkdir: /builds/slave/test/properties 07:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:31:05 INFO - Contents: 07:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:31:05 INFO - Running post-action listener: _resource_record_post_action 07:31:05 INFO - Running post-action listener: set_extra_try_arguments 07:31:05 INFO - [mozharness: 2017-01-17 15:31:05.861409Z] Finished download-and-extract step (success) 07:31:05 INFO - [mozharness: 2017-01-17 15:31:05.861528Z] Running populate-webroot step. 07:31:05 INFO - Running pre-action listener: _resource_record_pre_action 07:31:05 INFO - Running main action method: populate_webroot 07:31:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:31:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:31:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:31:05 INFO - '--tppagecycles', 07:31:05 INFO - '7'], 07:31:05 INFO - 'tests': ['tsvgm']}}, 07:31:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:31:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:31:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:31:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:31:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:31:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['damp', 'tps']}, 07:31:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'tests': ['damp', 'tps']}, 07:31:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['dromaeo_dom']}, 07:31:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:31:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['basic_compositor_video']}, 07:31:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:31:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['a11yr', 07:31:05 INFO - 'ts_paint', 07:31:05 INFO - 'tpaint', 07:31:05 INFO - 'sessionrestore', 07:31:05 INFO - 'sessionrestore_no_auto_restore', 07:31:05 INFO - 'tabpaint']}, 07:31:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:31:05 INFO - 'ts_paint', 07:31:05 INFO - 'tpaint', 07:31:05 INFO - 'sessionrestore', 07:31:05 INFO - 'sessionrestore_no_auto_restore', 07:31:05 INFO - 'tabpaint']}, 07:31:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:31:05 INFO - 'ts_paint', 07:31:05 INFO - 'tpaint', 07:31:05 INFO - 'sessionrestore', 07:31:05 INFO - 'sessionrestore_no_auto_restore', 07:31:05 INFO - 'tabpaint']}, 07:31:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:31:05 INFO - 'ts_paint', 07:31:05 INFO - 'tpaint', 07:31:05 INFO - 'sessionrestore', 07:31:05 INFO - 'sessionrestore_no_auto_restore', 07:31:05 INFO - 'tabpaint']}, 07:31:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['a11yr', 07:31:05 INFO - 'ts_paint', 07:31:05 INFO - 'tpaint', 07:31:05 INFO - 'sessionrestore', 07:31:05 INFO - 'sessionrestore_no_auto_restore', 07:31:05 INFO - 'tabpaint']}, 07:31:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['a11yr', 07:31:05 INFO - 'ts_paint', 07:31:05 INFO - 'tpaint', 07:31:05 INFO - 'sessionrestore', 07:31:05 INFO - 'sessionrestore_no_auto_restore', 07:31:05 INFO - 'tabpaint']}, 07:31:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['tsvgx', 07:31:05 INFO - 'tsvgr_opacity', 07:31:05 INFO - 'tart', 07:31:05 INFO - 'tscrollx', 07:31:05 INFO - 'cart', 07:31:05 INFO - 'tsvg_static']}, 07:31:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:31:05 INFO - 'tsvgr_opacity', 07:31:05 INFO - 'tart', 07:31:05 INFO - 'tscrollx', 07:31:05 INFO - 'cart', 07:31:05 INFO - 'tsvg_static']}, 07:31:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'talos_options': ['--disable-e10s'], 07:31:05 INFO - 'tests': ['tp5o']}, 07:31:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:31:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'talos_options': ['--disable-e10s', 07:31:05 INFO - '--xperf_path', 07:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:05 INFO - 'tests': ['tp5n']}, 07:31:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:31:05 INFO - 'talos_options': ['--xperf_path', 07:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:31:05 INFO - 'tests': ['tp5n']}}, 07:31:05 INFO - 'talos.zip': {'path': '', 07:31:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:31:05 INFO - Running post-action listener: _resource_record_post_action 07:31:05 INFO - [mozharness: 2017-01-17 15:31:05.879494Z] Finished populate-webroot step (success) 07:31:05 INFO - [mozharness: 2017-01-17 15:31:05.879571Z] Running create-virtualenv step. 07:31:05 INFO - Running pre-action listener: _resource_record_pre_action 07:31:05 INFO - Running main action method: create_virtualenv 07:31:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:31:05 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 07:31:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:31:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:31:06 INFO - Using real prefix '/tools/python27' 07:31:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:31:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:31:09 INFO - Installing pip.................done. 07:31:09 INFO - Return code: 0 07:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:31:09 INFO - Reading from file tmpfile_stdout 07:31:09 INFO - Output received: 07:31:09 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) 07:31:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:09 INFO - 'HOME': '/Users/cltbld', 07:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:09 INFO - 'LOGNAME': 'cltbld', 07:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:09 INFO - 'MOZ_NO_REMOTE': '1', 07:31:09 INFO - 'NO_EM_RESTART': '1', 07:31:09 INFO - 'PAGER': '/bin/cat', 07:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:09 INFO - 'PWD': '/builds/slave/test', 07:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:09 INFO - 'SHELL': '/bin/bash', 07:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:09 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:09 INFO - 'USER': 'cltbld', 07:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:09 INFO - 'XPC_FLAGS': '0x0', 07:31:09 INFO - 'XPC_SERVICE_NAME': '0', 07:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:10 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 07:31:10 INFO - Cleaning up... 07:31:10 INFO - Return code: 0 07:31:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:31:10 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')]} 07:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:10 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')]} 07:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:10 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 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:10 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 07:31:10 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 07:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:10 INFO - 'HOME': '/Users/cltbld', 07:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:10 INFO - 'LOGNAME': 'cltbld', 07:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:10 INFO - 'MOZ_NO_REMOTE': '1', 07:31:10 INFO - 'NO_EM_RESTART': '1', 07:31:10 INFO - 'PAGER': '/bin/cat', 07:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:10 INFO - 'PWD': '/builds/slave/test', 07:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:10 INFO - 'SHELL': '/bin/bash', 07:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:10 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:10 INFO - 'USER': 'cltbld', 07:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:10 INFO - 'XPC_FLAGS': '0x0', 07:31:10 INFO - 'XPC_SERVICE_NAME': '0', 07:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:10 INFO - Downloading/unpacking psutil>=3.1.1 07:31:10 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 07:31:10 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 07:31:10 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 07:31:10 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 07:31:10 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 07:31:10 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 07:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:31:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:14 INFO - Installing collected packages: psutil 07:31:14 INFO - Running setup.py install for psutil 07:31:14 INFO - building 'psutil._psutil_osx' extension 07:31:14 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 07:31:14 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 07:31:15 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 07:31:15 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 07:31:15 INFO - building 'psutil._psutil_posix' extension 07:31:15 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 07:31:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:31:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:31:15 INFO - ^ 07:31:15 INFO - 1 warning generated. 07:31:15 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 07:31:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:31:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:31:15 INFO - Successfully installed psutil 07:31:15 INFO - Cleaning up... 07:31:15 INFO - Return code: 0 07:31:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:31: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 mozsystemmonitor==0.3 07:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:15 INFO - 'HOME': '/Users/cltbld', 07:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:15 INFO - 'LOGNAME': 'cltbld', 07:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:15 INFO - 'MOZ_NO_REMOTE': '1', 07:31:15 INFO - 'NO_EM_RESTART': '1', 07:31:15 INFO - 'PAGER': '/bin/cat', 07:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:15 INFO - 'PWD': '/builds/slave/test', 07:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:15 INFO - 'SHELL': '/bin/bash', 07:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:15 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:15 INFO - 'USER': 'cltbld', 07:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:15 INFO - 'XPC_FLAGS': '0x0', 07:31:15 INFO - 'XPC_SERVICE_NAME': '0', 07:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:31:15 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 07:31:15 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 07:31:15 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 07:31:15 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 07:31:15 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 07:31:15 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 07:31:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:31:18 INFO - Installing collected packages: mozsystemmonitor 07:31:18 INFO - Running setup.py install for mozsystemmonitor 07:31:18 INFO - Successfully installed mozsystemmonitor 07:31:18 INFO - Cleaning up... 07:31:18 INFO - Return code: 0 07:31:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:31:18 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')]} 07:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:18 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')]} 07:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:18 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 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:18 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 07:31:18 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 07:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:18 INFO - 'HOME': '/Users/cltbld', 07:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:18 INFO - 'LOGNAME': 'cltbld', 07:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:18 INFO - 'MOZ_NO_REMOTE': '1', 07:31:18 INFO - 'NO_EM_RESTART': '1', 07:31:18 INFO - 'PAGER': '/bin/cat', 07:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:18 INFO - 'PWD': '/builds/slave/test', 07:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:18 INFO - 'SHELL': '/bin/bash', 07:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:18 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:18 INFO - 'USER': 'cltbld', 07:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:18 INFO - 'XPC_FLAGS': '0x0', 07:31:18 INFO - 'XPC_SERVICE_NAME': '0', 07:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:18 INFO - Downloading/unpacking jsonschema==2.5.1 07:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:31:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:31:22 INFO - warning: no files found matching '*.txt' 07:31:22 INFO - no previously-included directories found matching 'build' 07:31:22 INFO - no previously-included directories found matching 'dist' 07:31:22 INFO - no previously-included directories found matching '.git*' 07:31:22 INFO - Installing collected packages: jsonschema, functools32 07:31:22 INFO - Running setup.py install for functools32 07:31:22 INFO - warning: no files found matching '*.txt' 07:31:22 INFO - no previously-included directories found matching 'build' 07:31:22 INFO - no previously-included directories found matching 'dist' 07:31:22 INFO - no previously-included directories found matching '.git*' 07:31:22 INFO - Successfully installed jsonschema functools32 07:31:22 INFO - Cleaning up... 07:31:22 INFO - Return code: 0 07:31:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:31:22 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')]} 07:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:22 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')]} 07:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:22 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 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:22 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 07:31:22 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 07:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:22 INFO - 'HOME': '/Users/cltbld', 07:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:22 INFO - 'LOGNAME': 'cltbld', 07:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:22 INFO - 'MOZ_NO_REMOTE': '1', 07:31:22 INFO - 'NO_EM_RESTART': '1', 07:31:22 INFO - 'PAGER': '/bin/cat', 07:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:22 INFO - 'PWD': '/builds/slave/test', 07:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:22 INFO - 'SHELL': '/bin/bash', 07:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:22 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:22 INFO - 'USER': 'cltbld', 07:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:22 INFO - 'XPC_FLAGS': '0x0', 07:31:22 INFO - 'XPC_SERVICE_NAME': '0', 07:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:31:22 INFO - Cleaning up... 07:31:22 INFO - Return code: 0 07:31:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:31:22 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')]} 07:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:22 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')]} 07:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:22 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 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:22 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 07:31:22 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 07:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:22 INFO - 'HOME': '/Users/cltbld', 07:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:22 INFO - 'LOGNAME': 'cltbld', 07:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:22 INFO - 'MOZ_NO_REMOTE': '1', 07:31:22 INFO - 'NO_EM_RESTART': '1', 07:31:22 INFO - 'PAGER': '/bin/cat', 07:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:22 INFO - 'PWD': '/builds/slave/test', 07:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:22 INFO - 'SHELL': '/bin/bash', 07:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:22 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:22 INFO - 'USER': 'cltbld', 07:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:22 INFO - 'XPC_FLAGS': '0x0', 07:31:22 INFO - 'XPC_SERVICE_NAME': '0', 07:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:22 INFO - Downloading/unpacking blobuploader==1.2.4 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:22 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 07:31:25 INFO - Downloading blobuploader-1.2.4.tar.gz 07:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:31:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:31:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 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 07:31:26 INFO - Downloading docopt-0.6.1.tar.gz 07:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:31:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:31:26 INFO - Running setup.py install for blobuploader 07:31:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:31:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:31:27 INFO - Running setup.py install for requests 07:31:27 INFO - Running setup.py install for docopt 07:31:27 INFO - Successfully installed blobuploader requests docopt 07:31:27 INFO - Cleaning up... 07:31:27 INFO - Return code: 0 07:31:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:27 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')]} 07:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:27 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')]} 07:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:27 INFO - 'HOME': '/Users/cltbld', 07:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:27 INFO - 'LOGNAME': 'cltbld', 07:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:27 INFO - 'MOZ_NO_REMOTE': '1', 07:31:27 INFO - 'NO_EM_RESTART': '1', 07:31:27 INFO - 'PAGER': '/bin/cat', 07:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:27 INFO - 'PWD': '/builds/slave/test', 07:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:27 INFO - 'SHELL': '/bin/bash', 07:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:27 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:27 INFO - 'USER': 'cltbld', 07:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:27 INFO - 'XPC_FLAGS': '0x0', 07:31:27 INFO - 'XPC_SERVICE_NAME': '0', 07:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-9yPA4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-oLy7IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ud6gb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-aaXmL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-vS3TcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-KCV6QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-MEtPm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-xYiqSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:28 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-XUDc8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-rodoZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-x9H6Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-kp8X44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-qVP1GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-hoL8GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-oNKJGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-kO21XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:29 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-RPP0DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:31:29 INFO - Running setup.py install for manifestparser 07:31:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Running setup.py install for mozcrash 07:31:30 INFO - Running setup.py install for mozdebug 07:31:30 INFO - Running setup.py install for mozdevice 07:31:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Running setup.py install for mozfile 07:31:30 INFO - Running setup.py install for mozhttpd 07:31:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Running setup.py install for mozinfo 07:31:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:31:30 INFO - Running setup.py install for mozInstall 07:31:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozleak 07:31:31 INFO - Running setup.py install for mozlog 07:31:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for moznetwork 07:31:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozprocess 07:31:31 INFO - Running setup.py install for mozprofile 07:31:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozrunner 07:31:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:31:31 INFO - Running setup.py install for mozscreenshot 07:31:32 INFO - Running setup.py install for moztest 07:31:32 INFO - Running setup.py install for mozversion 07:31:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:31:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:31:32 INFO - Cleaning up... 07:31:32 INFO - Return code: 0 07:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:32 INFO - 'HOME': '/Users/cltbld', 07:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:32 INFO - 'LOGNAME': 'cltbld', 07:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:32 INFO - 'MOZ_NO_REMOTE': '1', 07:31:32 INFO - 'NO_EM_RESTART': '1', 07:31:32 INFO - 'PAGER': '/bin/cat', 07:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:32 INFO - 'PWD': '/builds/slave/test', 07:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:32 INFO - 'SHELL': '/bin/bash', 07:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:32 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:32 INFO - 'USER': 'cltbld', 07:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:32 INFO - 'XPC_FLAGS': '0x0', 07:31:32 INFO - 'XPC_SERVICE_NAME': '0', 07:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:32 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-0irCJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:32 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-NkNTDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:32 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)) 07:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:32 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-MJ2Yu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-_msCX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-JVjkCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-goMs1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-FTrPET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-f9X_dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-_aZBNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-gHCk_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-Q_9d0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:33 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)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ME9YJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:33 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-hYGfFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:34 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-sZ_VrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:34 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-nwrW6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:34 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-LS28Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:34 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-_2C82T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:31:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:31:37 INFO - Downloading blessings-1.6.tar.gz 07:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:37 INFO - Installing collected packages: blessings 07:31:37 INFO - Running setup.py install for blessings 07:31:37 INFO - Successfully installed blessings 07:31:37 INFO - Cleaning up... 07:31:37 INFO - Return code: 0 07:31:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:37 INFO - Reading from file tmpfile_stdout 07:31:37 INFO - Current package versions: 07:31:37 INFO - blessings == 1.6 07:31:37 INFO - blobuploader == 1.2.4 07:31:37 INFO - docopt == 0.6.1 07:31:37 INFO - functools32 == 3.2.3-2 07:31:37 INFO - jsonschema == 2.5.1 07:31:37 INFO - manifestparser == 1.1 07:31:37 INFO - mozInstall == 1.12 07:31:37 INFO - mozcrash == 1.0 07:31:37 INFO - mozdebug == 0.1 07:31:37 INFO - mozdevice == 0.49 07:31:37 INFO - mozfile == 1.2 07:31:37 INFO - mozhttpd == 0.7 07:31:37 INFO - mozinfo == 0.9 07:31:37 INFO - mozleak == 0.1 07:31:37 INFO - mozlog == 3.4 07:31:37 INFO - moznetwork == 0.27 07:31:37 INFO - mozprocess == 0.24 07:31:37 INFO - mozprofile == 0.28 07:31:37 INFO - mozrunner == 6.13 07:31:37 INFO - mozscreenshot == 0.1 07:31:37 INFO - mozsystemmonitor == 0.3 07:31:37 INFO - moztest == 0.8 07:31:37 INFO - mozversion == 1.4 07:31:37 INFO - psutil == 3.1.1 07:31:37 INFO - requests == 1.2.3 07:31:37 INFO - wsgiref == 0.1.2 07:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:37 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 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:37 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 07:31:37 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 07:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:37 INFO - 'HOME': '/Users/cltbld', 07:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:37 INFO - 'LOGNAME': 'cltbld', 07:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:37 INFO - 'MOZ_NO_REMOTE': '1', 07:31:37 INFO - 'NO_EM_RESTART': '1', 07:31:37 INFO - 'PAGER': '/bin/cat', 07:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:37 INFO - 'PWD': '/builds/slave/test', 07:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:37 INFO - 'SHELL': '/bin/bash', 07:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:37 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:37 INFO - 'USER': 'cltbld', 07:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:37 INFO - 'XPC_FLAGS': '0x0', 07:31:37 INFO - 'XPC_SERVICE_NAME': '0', 07:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 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)) 07:31:38 INFO - Cleaning up... 07:31:38 INFO - Return code: 0 07:31:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:38 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 0x10de69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc138ee3960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, '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.E5U7H2Q240/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.UfQOgZe3xL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 07:31:38 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 07:31:38 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 07:31:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:31:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:38 INFO - 'HOME': '/Users/cltbld', 07:31:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:38 INFO - 'LOGNAME': 'cltbld', 07:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:38 INFO - 'MOZ_NO_REMOTE': '1', 07:31:38 INFO - 'NO_EM_RESTART': '1', 07:31:38 INFO - 'PAGER': '/bin/cat', 07:31:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:38 INFO - 'PWD': '/builds/slave/test', 07:31:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:38 INFO - 'SHELL': '/bin/bash', 07:31:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:31:38 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:31:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:38 INFO - 'USER': 'cltbld', 07:31:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:38 INFO - 'XPC_FLAGS': '0x0', 07:31:38 INFO - 'XPC_SERVICE_NAME': '0', 07:31:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:31:38 INFO - Cleaning up... 07:31:38 INFO - Return code: 0 07:31:38 INFO - Running post-action listener: _resource_record_post_action 07:31:38 INFO - Running post-action listener: _start_resource_monitoring 07:31:38 INFO - Starting resource monitoring. 07:31:38 INFO - [mozharness: 2017-01-17 15:31:38.361071Z] Finished create-virtualenv step (success) 07:31:38 INFO - [mozharness: 2017-01-17 15:31:38.362119Z] Running install step. 07:31:38 INFO - Running pre-action listener: _resource_record_pre_action 07:31:38 INFO - Running main action method: install 07:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:38 INFO - Reading from file tmpfile_stdout 07:31:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:38 INFO - Reading from file tmpfile_stdout 07:31:38 INFO - Output received: 07:31:38 INFO - Usage: mozinstall [options] installer 07:31:38 INFO - Options: 07:31:38 INFO - -h, --help show this help message and exit 07:31:38 INFO - -d DEST, --destination=DEST 07:31:38 INFO - Directory to install application into. [default: 07:31:38 INFO - "/builds/slave/test"] 07:31:38 INFO - --app=APP Application being installed. [default: firefox] 07:31:38 INFO - mkdir: /builds/slave/test/build/application 07:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:32:00 INFO - Reading from file tmpfile_stdout 07:32:00 INFO - Output received: 07:32:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:32:00 INFO - Running post-action listener: _resource_record_post_action 07:32:00 INFO - [mozharness: 2017-01-17 15:32:00.454223Z] Finished install step (success) 07:32:00 INFO - [mozharness: 2017-01-17 15:32:00.454344Z] Running run-tests step. 07:32:00 INFO - Running pre-action listener: _resource_record_pre_action 07:32:00 INFO - Running main action method: run_tests 07:32:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:32:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:32:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:32:00 INFO - 2017-01-17 07:32:00.468 screenresolution[1637:9228] starting screenresolution argv=screenresolution get 07:32:00 INFO - 2017-01-17 07:32:00.471 screenresolution[1637:9228] Display 0: 1600x1200x32@60 07:32:00 INFO - 2017-01-17 07:32:00.477 screenresolution[1638:9231] starting screenresolution argv=screenresolution list 07:32:00 INFO - Available Modes on Display 0 07:32:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:32:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:32:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:32:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:32:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:32:00 INFO - Intel Iris: 07:32:00 INFO - Chipset Model: Intel Iris 07:32:00 INFO - Type: GPU 07:32:00 INFO - Bus: Built-In 07:32:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:32:00 INFO - Vendor: Intel (0x8086) 07:32:00 INFO - Device ID: 0x0a2e 07:32:00 INFO - Revision ID: 0x0009 07:32:00 INFO - Displays: 07:32:00 INFO - Display: 07:32:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:32:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:32:00 INFO - Display Serial Number: 1600x1200 60 07:32:00 INFO - Main Display: Yes 07:32:00 INFO - Mirror: Off 07:32:00 INFO - Online: Yes 07:32:00 INFO - Rotation: Supported 07:32:00 INFO - Return code: 0 07:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:32:00 INFO - Python 2.7.3 07:32:00 INFO - Return code: 0 07:32:00 INFO - grabbing minidump binary from tooltool 07:32:00 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')]} 07:32:00 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 0x10dc47d30>, '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 0x10db6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc3cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:32:00 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 07:32:00 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 07:32:00 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 07:32:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:32:00 INFO - Return code: 0 07:32:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:32:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:32:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:32:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:32:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 07:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0297 --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 07:32:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E5U7H2Q240/Render', 07:32:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:00 INFO - 'HOME': '/Users/cltbld', 07:32:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:00 INFO - 'LOGNAME': 'cltbld', 07:32:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:32:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:00 INFO - 'MOZ_NO_REMOTE': '1', 07:32:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:32:00 INFO - 'NO_EM_RESTART': '1', 07:32:00 INFO - 'PAGER': '/bin/cat', 07:32:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:00 INFO - 'PWD': '/builds/slave/test', 07:32:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:32:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:00 INFO - 'SHELL': '/bin/bash', 07:32:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UfQOgZe3xL/Listeners', 07:32:00 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 07:32:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:00 INFO - 'USER': 'cltbld', 07:32:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:00 INFO - 'XPC_FLAGS': '0x0', 07:32:00 INFO - 'XPC_SERVICE_NAME': '0', 07:32:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 07:32:01 INFO - mozversion application_buildid: 20170117065524 07:32:01 INFO - mozversion application_changeset: 7a4f03169c77e4618312be942f7c5fa17f7bcb68 07:32:01 INFO - mozversion application_display_name: Nightly 07:32:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:32:01 INFO - mozversion application_name: Firefox 07:32:01 INFO - mozversion application_remotingname: firefox 07:32:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:32:01 INFO - mozversion application_vendor: Mozilla 07:32:01 INFO - mozversion application_version: 53.0a1 07:32:01 INFO - mozversion platform_buildid: 20170117065524 07:32:01 INFO - mozversion platform_changeset: 7a4f03169c77e4618312be942f7c5fa17f7bcb68 07:32:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:32:01 INFO - mozversion platform_version: 53.0a1 07:32:01 INFO - using testdate: 1484667121 07:32:01 INFO - actual date: 1484667121 07:32:01 INFO - starting webserver on 'localhost:49247' 07:32:01 INFO - SUITE-START | Running 2 tests 07:32:01 INFO - TEST-START | dromaeo_css 07:32:01 INFO - operating with platform_type : mac_ 07:32:01 INFO - Initialising browser for dromaeo_css test... 07:32:01 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpIEXMBQ/profile http://localhost:49247/getInfo.html) 07:32:03 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 07:32:03 INFO - PROCESS | 1648 | colorDepth:24 07:32:03 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 07:32:03 INFO - PROCESS | 1648 | __metrics 07:32:03 INFO - PROCESS | 1648 | 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:32:03 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:32:04 INFO - TEST-INFO | 1648: exit 0 07:32:04 INFO - Browser initialized. 07:32:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:32:04 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpIEXMBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:16 INFO - PROCESS | 1651 | RSS: Main: 235442176 07:32:16 INFO - PROCESS | 1651 | 07:35:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 07:35:22 INFO - PROCESS | 1651 | RSS: Main: 352636928 07:35:22 INFO - PROCESS | 1651 | 07:37:05 INFO - PROCESS | 1651 | ************************* 07:37:05 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 07:37:05 INFO - PROCESS | 1651 | 07:37:05 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:37:05 INFO - PROCESS | 1651 | Full stack: 07:37:05 INFO - PROCESS | 1651 | ************************* 07:38:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 07:38:26 INFO - PROCESS | 1651 | RSS: Main: 367038464 07:38:26 INFO - PROCESS | 1651 | 07:41:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 07:41:29 INFO - PROCESS | 1651 | RSS: Main: 347693056 07:41:29 INFO - PROCESS | 1651 | 07:44:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 07:44:32 INFO - PROCESS | 1651 | RSS: Main: 332374016 07:44:32 INFO - PROCESS | 1651 | 07:47:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 07:47:36 INFO - PROCESS | 1651 | RSS: Main: 332546048 07:47:36 INFO - PROCESS | 1651 | 07:50:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 07:50:40 INFO - PROCESS | 1651 | RSS: Main: 398508032 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | __start_tp_report 07:50:40 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 07:50:40 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 07:50:40 INFO - PROCESS | 1651 | |i|pagename|runs| 07:50:40 INFO - PROCESS | 1651 | |0;dojo.html;3353.8993830185086;3357.6138744044442;3361.8487168077436;3371.578552680915;3427.126082848873;5606.719664016803;5650.74571644276;5703.543716502681;5768.365479797224;5791;5681.233033540481;5756.597038207327;5842.503387212081;5880.852978675535;5897.616654917428;5153.896922061556;5156.74216289184;5180.171172612364;5250.028744682227;5283.841484755463;5355.705436201008;5363.9463605363835;5369;5377.7580008899695;5416.972915135439;5144.305518754958;5242.501962313574;5261.631685781997;5274.709890956015;5307.840764777044;5156.2007888776925;5179.249008893689;5234.790608375661;5242.082635538765;5244.449332820075;5234.92147617786;5244.763985620656;5267.736613169364;5268.209768534751;5282.260483532308;5693.886122277573;5738.454846789548;5742.368339482696;5746.367899531048;5763.193152958589;6171.87656246877;6174.84562885927;6285.937140628626;6297.937020629826;6306.337834527354;5911.320198177222;6213;6267;6275.811725648238;6315.715792789336;5790.855228619234;5838.380204273378;5851.502622277069;5864.266966629171;5896.882062358814;6202.162708034448;6238.781642642576;6270.717817698214;6281.403266689657;6299.622022678654;6119.571629985947;6143.232095988002;6153.661548614869;6194.442500175006;6202.038684003986;6122.947104152868;6291.96854015727;6297.055441683784;6298.937010629835;6299.275583307886;6083.878322433527;6135.631862088289;6169.167162433104;6171.722272497748;6172.259328880563;6237.719302631302;6277.5605707600025;6290.496760259169;6298.527610429236;6300.779472718433;4043.7169398141846;4927.162382394929;4948.455669876311;5014.2979982802435;5047.570956468668;4441.400410944546;4443.37792709021;4454.465464144323;4467.709598876063;4533.161365147458;5895.970520147372;5900.586958912921;5915.585908986416;5923.496502797224;5960.940390596125;6300.936990630126;6304.8423789404715;6306.4639505642535;6309.652969086653;6313.873722525524;5690.089585666274;5699.914501282484;5746.88506229873;5789.8552536186935;5887.941120588825;5451.509364157245;5459.5359394451125;5502.724863756796;5525;5541.889162216733;5257.710825904612;6325.557210995186;6346.7461301549265;6351.96824015877;6367.681615919279;5533.6126471148245;6106.096658337741;6216.7824126155365;6294.464970477561;6302.3067462578165;6233.127362169209;6250.593711408744;6263.78076767311;6359.96820015897;6374.681265936777;6243.469305109116;6263.311035785969;6266.843328916813;6270.49836013127;6290.937090629035;5263.394709608444;6231.283402408781;6245.250569931637;6281.560290779602;6298.84252893663;4957.256411538298;6018.307894592178;6087.117367981707;6087.147799308012;6137.877242455215;6144.969275153596;6145.125736650186;6151.200343955257;6158.876822463615;6170;5834.591578589458;5930.881382372415;5941.079132734433;5965.880682386415;6071.878562428815;6094.024956007018;6115;6122.001753127661;6123.343628574205;6147.477464415396;5840.883182336414;6032.276126864805;6033.969830150997;6043.697815109315;6080.574359794772 07:50:40 INFO - PROCESS | 1651 | |1;ext.html;429.9720518166317;498.48157915767626;504.1958076867396;507.30499216073974;521.4576840086311;30006.549901751492;39388.80305598472;41128.58871411293;41128.79435602818;43133;37410.0647483813;42542.93642658927;42882;42956.78521607396;42958.35562466558;8221.013478382603;9090.090990900922;9438.480883551401;9438.575264113097;9477.383970041925;7118.644067796616;11028.724281892937;11273.718157046058;11294.774104517905;11507.59723409681;11300.943495282512;11365.374904380256;11385.08919286455;11387.54449822006;11399.430028498542;8261.793455163668;8467;11267.492962816652;11339.716507087307;11374.146938979567;8462.449940753831;8512.021117571496;8948.776280592972;11111.666650000512;11148.721281967935;40194;40514.39228411576;40568;40620;40745.79627101846;4011.5988401159652;4038.9798051009852;4049.1496785675045;4076.8369265229353;4088.4480595119576;30451.086467406014;31122.688773112204;31199.688003119903;31244.687553124404;31679.366412671618;3160.541721450377;3163.43058249515;3179.666135055832;3196.216926852936;3290.588676415448;436084;437014;437180;439127;439523;57730.42269577335;58164;58176;58238.70880645655;58293.8341233173;60960.085598716054;61280.77438451206;61283.387166127766;61288;61355;15515.922420388051;16063.598410039609;16075.276612552463;16094.19529023544;16139.031658100552;11090.889091109148;11406.885931140583;12312.322822244863;12498;12588.748225035448;15221.31504082319;15233;15292.541223763305;15303.846961530242;15408.691826163415;6269.529785266032;6274.529410294155;6306.959351707009;6342.365763423713;6349.492040636738;795.7135431244748;824.2416976381743;835.0730688935276;891.4517571693361;915.839728047589;29072.41855162885;29927.551086733718;30203.697963020528;30446.086617401514;30744;1020.3061917895753;1069.887661795516;1081.7674200047027;1093.688298834844;1135.1202817816259;12591.433385497674;13481.528146514825;13941;14256.501022464165;14272.785908211385;615042.8495715075;618169;618303;619082.9045854833;620497.8975105096;49895.25157122646;50067;50105;50150.49849501458;50201;1411.7247136808223;1421.3319739722315;1443.364919435466;1450.2966061460183;1455.4760286296712;25495.107671231417;26252.60621090647;26867.731322687305;26870.731292687604;27430.725692742817;36983.44524832076;41122.794386027876;44544;44577.777111114236;44667.55332446634;550131;551473;552655;554707;555987;21169.894150529766;21607.703537787784;21652.783472165076;23574.646380303966;23890.924908378816;40696.59303406928;40941.59058409378;41480.79259603683;42899.568034557786;43054.13891722211;34003;35356;35373.64626353703;36190.009549475035;36330.63669363378;35421.04105425294;35543.46684799782;35996.64003360038;36226.73206437762;36364.45453318255;34393;34618.94168520549;35574.46638300376;35681.82159089188;36670.266594668494;29995.70004299929;31542.526862097548;31563.89526366658;31652.050438486884;31690.683093168773;19631.411057668294;23056.38605297613;23653.52692946166;24211.757882421654;24356.372289264982 07:50:40 INFO - PROCESS | 1651 | |2;jquery.html;377.2568040959313;395.4680954116713;400.079816422229;411.6727201874509;427.3653624367813;13958.162510249393;15867.127307998055;18047.4585762427;20526.897365513152;21043.36869893902;21115.683264751002;21337.466563335925;21491;21845.344639660794;21948.780512194873;5777.653340799566;5802.796902108437;5944.435278648543;6004.309504406983;6061.272647282332;4174.749515029108;5437.13005919053;5464.153056276264;5562.9443705562835;5588.441155884399;4358.171947329997;4381.101874115799;4383.736975781463;5995.836904616138;6654.367835055662;5683.54531637468;6618.834529136762;6627.73489060437;6633.900491492632;6643.568168069109;5052.444231134572;5294.602904782157;5348.839534813962;5391.272178255964;5394.136938089926;13297.601071967856;13321.533746318832;13359.799603005962;13528.661783455493;13536.59390218295;2544.185860524633;2629.6581444412295;2698.2310041638234;2699.0553306342817;2701.081632245046;9656.324057315991;10229.897701022968;14055.64860878476;14782.778258326134;15649.843501564952;1759.683257013737;1787.7765279340083;1795.9640807183914;1797.9370722024796;1802.78366596008;94118.52940735321;128499;129917;133155.33422332924;133461;10033.548490317808;11081.556737730562;11214.943925280484;11370.97661210495;11546.59586914454;15163.545093646988;15169.544913652388;15172.620684482756;15186.696266074616;15214.315355809014;8202.097769245378;8428.578571071423;8452.704155354657;8600.526971016528;8679.262262707614;8249.29880960125;8252;8257.339412846957;8365.498070115813;8419.326453883674;4537.160625284333;4621.716356189204;4633.397658304399;4707.599854012447;4745.264484004984;1971.9309824156085;2009.2063634864146;2031.3296612117965;2033.2070492507933;2037.2564014134734;1013.0578561937469;1020.3316827478013;1031.8297480915714;1040.2731465766942;1052.032130439997;20396.898015510124;20765.688514672293;20785;21062.262820801505;21144.47138821511;1024.5491983527372;1032.3599368391644;1034.2294990232326;1073.7852429514128;1084.479449864054;10644.840327395095;10966.451677416257;11026.669199924016;11046.33721976668;11140.721481962853;591617;621309.8934505299;706855;730161.1427485669;733252;103326;113131.43434282776;143455;145306.74279200743;153096;449.77286470332274;459.59325996493345;473.16722568280073;473.644766425188;474.9833755818599;10065.748356291151;10228.948855255676;10890.074343680875;11445.885541144482;11539.115221194701;56448.15327770005;59582;59896.10155847753;60418.697906511945;61158.694206528686;86659;90197.54901225452;91170;92460.53769731108;92605.5369723147;7799.688012479437;8189.754307370788;8319.459235149696;8482.872756908775;8780.209781119729;7536.9246307538415;9716.659916902874;10825.296355736851;13055.086143969831;13078;10080.092791648787;10991.670249892515;11052.115830733683;11676.06591472697;11780.234284771463;9350;10753.408562529135;11654;11808.468618911998;11843.881561184278;10342.32774869631;11020;11344.886551134383;11616;11940;8441.113683063435;8445.78885527842;8575.228229459379;8610.78473038154;8682.39985209549;9575.760605984906;11054.723631909266;11595.768084638428;11747.236429632047;11795.233309834834 07:50:40 INFO - PROCESS | 1651 | |3;mootools.html;1212.9332886691234;1402.57221547428;1408.6830463145786;1416.157386355119;1419.4747943260995;6833.965830170849;8431;8452.535110568931;8458.111898250687;8468.915310846889;7417.443691723115;7685.385169186466;8026.43814932955;8183.508989460636;8277.337812974962;2281.235786011688;2312.7224733031976;2312.7340355859124;2316.131450705985;2319.8724070176136;1774.8491378232866;2265.150568536799;2335.7547457516885;2355.858648481088;2370.8103351731907;2043.4278402047375;2118.9788102119014;2121.0561300221407;2220.322801545528;2294.4837411582425;2309.7805708457668;2328.196772113618;2333.9066437342485;2337.4623836517694;2340.719113706366;2004.8195662390308;2261.6607508873635;2349.706286714161;2353.5645905507363;2354.85870847748;8354.248117669438;8375.958120209421;8439.83120337596;8468.153184681543;8471.279941205004;5008.223725322581;5153.6907785532985;5161.380634323905;5173;5175.741212939376;3342.242649813889;3351.631320554737;3420.0423881313022;3540.345036168317;3544.61009288978;1195.8564972203305;1202.4769225386985;1244.7386048929645;1259.3514340114848;1259.6850787303174;10720;10787.406692631903;10821;10842.891571084347;10869.184811139117;4375.7155784873885;4601.861944141681;4668.043051174501;4681.695689780154;4691.413573303337;9418.62325506972;9448.102430269113;9448.527573621292;9457.621695132255;9471.952640236756;5207.218917162456;5211.296474975906;5219.295395121686;5222.582193424517;5223.112070947948;4587.38070360497;4692.724028846007;4757.429108507002;4799.832005879777;4812.783424745895;3744.9063773405883;3773.4905787718308;3819.3316169670197;3843.0584506796013;3860.8841734748003;1260.4832018872219;1265.7974724044109;1273.2042473454092;1287.9678008049686;1288.903332250085;712.5902606001466;771.2827070824187;786.1745167574024;793.984120317602;834.3408707121428;5302.549283310885;5466.781328746805;5781.855453613609;5786.276715410574;5904.76380944766;953.323140570189;993.732990437184;996.4270544436978;1014.1075853249241;1036.6682661548232;3570.785752854837;3691.5016472775833;3796.2597293527497;3830.3871380578976;3830.578636349999;9679.9032009679;10005.949970250102;10013.048760367754;10014.799704006025;10016.399016058915;9694.466804325688;9994.050565196294;10000;10099.697009089592;10124.088832005154;7561.735339263099;7829.295363417434;7844.882326765103;7845.921540784633;7862.646180921758;5467.20725494809;5470.17947307907;5529.778808847762;5550.389457159628;5589.273394458694;8975.640974361213;9159.954200228956;9210.723678289662;9269.629214831331;9326.860097098684;9197.264218862341;9247.953760231425;9408.106229908148;9448.622055117994;9527.714168574954;6679.265280819009;6679.4990375721045;6787.796366109024;6794.830129246809;6798.252192258947;7771.883421748791;7786.143524212445;7793.06483222017;7800.882986755089;7911.5253084815095;6318.4313411793155;7055.717771289091;7094.64526773649;7147.678354473957;7150.6424678764815;6992;7032.12098487689;7066.222715501188;7098.041764361951;7114.537555058904;6281.466075383643;6291.339409361951;6292.370762923671;6356;6369.681515924278;4494.438195225597;4818.301346304696;4840.636952228527;4939.308496810521;5017.197248440232;4969.403671559291;4996.575291100297;5038.269450929668;5063.088644044107;5111.539961403491 07:50:40 INFO - PROCESS | 1651 | |4;prototype.html;363.44755970924194;365.1364522903333;373.7888093227326;374.6422166830677;376.67794036099133;5188.2995795567585;5260.132078207101;5369.610523317126;5410.83767486975;5414.646338415396;4235.724677895934;4399.582039706231;5250.894982100355;5314.76083576239;5385.380681221661;4132.400801883732;4195.895102622444;4229.830806767725;4234.649769377994;4242.639375653073;3799.96701764556;3891.835735762735;4011.458453108822;4163.666906647476;4250.83102146909;3520.9789161143367;4118.114605359847;4197.265478541259;4206.852760153395;4229.471316085489;3775.5846856845724;4044.69664775143;4187.581241875803;4204.600562946515;4226.450561427026;3635.8545658173643;3721.6836568891677;3758.924821503582;3773.660370566662;3786.5266841644793;4366.8034938427845;5267.3679158500845;5279.392869819943;5290.418054014055;5292.444293349181;4870.342503761982;4888.071266459361;4894.580571634222;4900.558949694509;4910.37295047148;4783.282507623884;5383.353997520284;5661.801836935729;5670.193254339088;5753.453421924911;3508.5088087667746;3995.640392364672;4081.3265811141127;4097.549269580344;4101.692373072032;5856.824295271149;5896.410358964112;5899.616524925909;5931.940680593182;5980.581359304894;3673.412254039341;4034.495688038995;4180.979095104566;4189.601987811153;4196.916061678749;3288.9835550822095;3573.1960308930284;3598.892033239007;3705.870294539732;4203.616089048284;4811.759412029384;4814.398200224972;4828.903421931542;4830.058138662927;4935.580475659609;4772.952270477251;4839.127661271036;5649.485978739422;5687.886242275132;5717.771289148387;1244.595506460404;1271.4786937355639;1311.4033114932683;1385.3350391811987;1395.6720170759863;876.1851478125404;911.293747345799;925.1165137293868;939.5155654066558;992.2211064314623;3998.140399814054;4469.754163521037;4980.950190498121;5081.034603425337;5103.566196873233;4367.803448844746;4788.281757736368;5144.803748214331;5342.225377320345;5461.617686761968;4414.4702635683925;4517.81928722854;4705.717656940595;4966.900661986812;4977.452480227172;2592.2223333000024;2705.0937935791335;2776.6112744215825;2836.163331817119;2951.2474319048506;5316.548093412103;5735.4551317624755;5805.41658961758;5827.59206855516;5861.706914654335;4670.322803193518;4963.851084467472;5341.813036543703;5412.107002344648;5754.482096611325;4662.53374662531;5229.424763276036;5500.4499550044675;5767.798127065533;5804.970975145097;4407.493138289138;4957.801687932442;5495.752691128829;5517.917231241615;5588.552915766648;4416.072624748838;4512.984578469818;5395.406505284337;5431.511163995259;5455.454454554513;5154.8969020620125;5750.856228594319;5771.7402716877;5781.94218057814;5816.76732930678;4008.2183974124764;4027.7180597357906;4030.3954406839207;4118.487722489339;4125.711200216077;4703.647226457961;5133.948660513496;5826.650400975955;5877.941220587911;5884.146798714248;4481.624738888394;4715.929261061018;4883.536064073907;5502.449755024466;5760.819032098493;5347.919781203207;5644.569013324521;5719.685417301922;5723.828285151286;5726.5418766499415;4937.790436216488;5327.334083239595;5530.778768849362;5586.525145362527;5605;4754.572088512051;5126.512981266774;5268.947310526845;5387.919181212206;5709;5497.862553436036;5549.639273447213;5562.527185189304;5586.720663966704;5596.3284405871555 07:50:40 INFO - PROCESS | 1651 | |5;yui.html;727.5780047572405;740.7628662743804;779.5829231361223;822.325692931796;823.6458322921144;14883.255837208137;15880.920595397036;15909.761353579677;15914.68170636588;15949.441769538054;14409.92795036026;14589.270536473186;14593.9784215105;14607.050541714782;14615.926920365384;560.2576586023515;699.7585832887646;711.1501755402296;865.2558799432483;877.6840337478519;893.8033632600817;900.5992333411634;902.0843843498822;903.9005709371963;906.755176102452;939.3330735178032;953.5661274120258;953.7091187187905;957.5308099031494;961.7307153996892;949.6628696812601;949.7008442340641;951.7953639967441;951.8477043672979;955.7897262602252;544.5425842292453;560.3611882454006;561.9494245517882;712.8538649576876;717.096458462336;12423.31671758053;12470.875291247063;14529.418823247057;14998.325075371635;15095;14093.85906140946;14321.928390358085;14388.136711797326;14407.135571865721;14427.990040697156;11773.705657358549;11790.79118480906;11973.221740586834;12134.029277657766;12148.696282593006;3697.038769919813;3698.408254679265;3853.730238883279;3918.9412158817354;3923.5487918889407;98985;102354;102935.97064029338;104076.47961760142;105076;11293;11354.602588909349;11387.601433949772;11409.543618255342;11447.25592836463;21165.89417052936;23050.308490745305;23235.186768463023;23237.41906452352;23240;7732.110807257125;7834.4907581007055;7879.369650427952;7938.444308898322;8166.959165204136;4383.430154079949;4385.539518350591;4399.494058183286;4403.137960325814;4452.4211852458975;3150.763692723055;3527.8412471438846;3612.9638703612627;3684.6868016218386;3695.796731179757;584.3455330030393;618.7648693496443;671.1375881991618;681.3731367142241;685.2975699907635;630.489976506265;633.6071635585874;646.3407324528954;650.7364517370472;665.4443539644354;10044.547995340226;10366.481675916173;10446.477676116163;10455;10501.264911456277;668.582136164897;683.4771399879096;695.1380288442296;695.2317688953734;712.237905441173;4547.704399214041;4938.580220681282;4952.975235123801;4972.353594032825;4984.277279794482;98760.50619747;103612;106119;106957.39563906548;107156;90444;91240.5437972806;92790.53604731933;93824.0617593829;95693.5215323919;77388;78202.6089869547;78903.60548197222;80388.99027524475;82378;10526.789464210826;10698.251122421356;10879.23845330851;11070.612528561462;11134.615863218998;36373.09067273234;42335.576644233166;43619.78190109029;49734;50249.74875125601;61454.0781888281;63704;66982.66034679182;67025.32436689122;69522;11515.769684606094;13170.736585268049;13340.399682014138;13491.123076999964;13781.173129612256;14710.264486775832;14758.631034223801;14836;14852.7772083421;14914.552563423114;13798;14218.786718199442;14276.643718846693;14501.129932204101;14522.709545809235;11628.76742465129;13312.183940052626;13557.93221033928;13589.52436664712;14090.718185636024;13339.132956357806;13396.330183490982;13666.248356340497;14095.365708543346;14273.928630357197;11105.944470277596;11285.548578057114;11615.361155136548;11624.82562761576;11640.185187036826;10904.727381815517;11130.109591232844;11357.886421135683;11378.54485820591;11635.941820290844 07:50:40 INFO - PROCESS | 1651 | __end_tp_report 07:50:40 INFO - PROCESS | 1651 | __start_cc_report 07:50:40 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1263 07:50:40 INFO - PROCESS | 1651 | __end_cc_report 07:50:40 INFO - PROCESS | 1651 | __startTimestamp1484668240084__endTimestamp 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | ------- Summary: start ------- 07:50:40 INFO - PROCESS | 1651 | Number of tests: 6 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5758.00 Median:5941.08 stddev:644.30 (10.8%) stddev-sans-first:618.06 07:50:40 INFO - PROCESS | 1651 | Values: 3353.9 3357.6 3361.8 3371.6 3427.1 5606.7 5650.7 5703.5 5768.4 5791.0 5681.2 5756.6 5842.5 5880.9 5897.6 5153.9 5156.7 5180.2 5250.0 5283.8 5355.7 5363.9 5369.0 5377.8 5417.0 5144.3 5242.5 5261.6 5274.7 5307.8 5156.2 5179.2 5234.8 5242.1 5244.4 5234.9 5244.8 5267.7 5268.2 5282.3 5693.9 5738.5 5742.4 5746.4 5763.2 6171.9 6174.8 6285.9 6297.9 6306.3 5911.3 6213.0 6267.0 6275.8 6315.7 5790.9 5838.4 5851.5 5864.3 5896.9 6202.2 6238.8 6270.7 6281.4 6299.6 6119.6 6143.2 6153.7 6194.4 6202.0 6122.9 6292.0 6297.1 6298.9 6299.3 6083.9 6135.6 6169.2 6171.7 6172.3 6237.7 6277.6 6290.5 6298.5 6300.8 4043.7 4927.2 4948.5 5014.3 5047.6 4441.4 4443.4 4454.5 4467.7 4533.2 5896.0 5900.6 5915.6 5923.5 5960.9 6300.9 6304.8 6306.5 6309.7 6313.9 5690.1 5699.9 5746.9 5789.9 5887.9 5451.5 5459.5 5502.7 5525.0 5541.9 5257.7 6325.6 6346.7 6352.0 6367.7 5533.6 6106.1 6216.8 6294.5 6302.3 6233.1 6250.6 6263.8 6360.0 6374.7 6243.5 6263.3 6266.8 6270.5 6290.9 5263.4 6231.3 6245.3 6281.6 6298.8 4957.3 6018.3 6087.1 6087.1 6137.9 6145.0 6145.1 6151.2 6158.9 6170.0 5834.6 5930.9 5941.1 5965.9 6071.9 6094.0 6115.0 6122.0 6123.3 6147.5 5840.9 6032.3 6034.0 6043.7 6080.6 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:66115.71 Median:36208.37 stddev:144761.77 (399.8%) stddev-sans-first:145083.86 07:50:40 INFO - PROCESS | 1651 | Values: 430.0 498.5 504.2 507.3 521.5 30006.5 39388.8 41128.6 41128.8 43133.0 37410.1 42542.9 42882.0 42956.8 42958.4 8221.0 9090.1 9438.5 9438.6 9477.4 7118.6 11028.7 11273.7 11294.8 11507.6 11300.9 11365.4 11385.1 11387.5 11399.4 8261.8 8467.0 11267.5 11339.7 11374.1 8462.4 8512.0 8948.8 11111.7 11148.7 40194.0 40514.4 40568.0 40620.0 40745.8 4011.6 4039.0 4049.1 4076.8 4088.4 30451.1 31122.7 31199.7 31244.7 31679.4 3160.5 3163.4 3179.7 3196.2 3290.6 436084.0 437014.0 437180.0 439127.0 439523.0 57730.4 58164.0 58176.0 58238.7 58293.8 60960.1 61280.8 61283.4 61288.0 61355.0 15515.9 16063.6 16075.3 16094.2 16139.0 11090.9 11406.9 12312.3 12498.0 12588.7 15221.3 15233.0 15292.5 15303.8 15408.7 6269.5 6274.5 6307.0 6342.4 6349.5 795.7 824.2 835.1 891.5 915.8 29072.4 29927.6 30203.7 30446.1 30744.0 1020.3 1069.9 1081.8 1093.7 1135.1 12591.4 13481.5 13941.0 14256.5 14272.8 615042.8 618169.0 618303.0 619082.9 620497.9 49895.3 50067.0 50105.0 50150.5 50201.0 1411.7 1421.3 1443.4 1450.3 1455.5 25495.1 26252.6 26867.7 26870.7 27430.7 36983.4 41122.8 44544.0 44577.8 44667.6 550131.0 551473.0 552655.0 554707.0 555987.0 21169.9 21607.7 21652.8 23574.6 23890.9 40696.6 40941.6 41480.8 42899.6 43054.1 34003.0 35356.0 35373.6 36190.0 36330.6 35421.0 35543.5 35996.6 36226.7 36364.5 34393.0 34618.9 35574.5 35681.8 36670.3 29995.7 31542.5 31563.9 31652.1 31690.7 19631.4 23056.4 23653.5 24211.8 24356.4 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:37445.57 Median:21414.23 stddev:113246.55 (528.8%) stddev-sans-first:113530.03 07:50:40 INFO - PROCESS | 1651 | Values: 377.3 395.5 400.1 411.7 427.4 13958.2 15867.1 18047.5 20526.9 21043.4 21115.7 21337.5 21491.0 21845.3 21948.8 5777.7 5802.8 5944.4 6004.3 6061.3 4174.7 5437.1 5464.2 5562.9 5588.4 4358.2 4381.1 4383.7 5995.8 6654.4 5683.5 6618.8 6627.7 6633.9 6643.6 5052.4 5294.6 5348.8 5391.3 5394.1 13297.6 13321.5 13359.8 13528.7 13536.6 2544.2 2629.7 2698.2 2699.1 2701.1 9656.3 10229.9 14055.6 14782.8 15649.8 1759.7 1787.8 1796.0 1797.9 1802.8 94118.5 128499.0 129917.0 133155.3 133461.0 10033.5 11081.6 11214.9 11371.0 11546.6 15163.5 15169.5 15172.6 15186.7 15214.3 8202.1 8428.6 8452.7 8600.5 8679.3 8249.3 8252.0 8257.3 8365.5 8419.3 4537.2 4621.7 4633.4 4707.6 4745.3 1971.9 2009.2 2031.3 2033.2 2037.3 1013.1 1020.3 1031.8 1040.3 1052.0 20396.9 20765.7 20785.0 21062.3 21144.5 1024.5 1032.4 1034.2 1073.8 1084.5 10644.8 10966.5 11026.7 11046.3 11140.7 591617.0 621309.9 706855.0 730161.1 733252.0 103326.0 113131.4 143455.0 145306.7 153096.0 449.8 459.6 473.2 473.6 475.0 10065.7 10228.9 10890.1 11445.9 11539.1 56448.2 59582.0 59896.1 60418.7 61158.7 86659.0 90197.5 91170.0 92460.5 92605.5 7799.7 8189.8 8319.5 8482.9 8780.2 7536.9 9716.7 10825.3 13055.1 13078.0 10080.1 10991.7 11052.1 11676.1 11780.2 9350.0 10753.4 11654.0 11808.5 11843.9 10342.3 11020.0 11344.9 11616.0 11940.0 8441.1 8445.8 8575.2 8610.8 8682.4 9575.8 11054.7 11595.8 11747.2 11795.2 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5403.80 Median:5157.54 stddev:2953.08 (57.3%) stddev-sans-first:2944.57 07:50:40 INFO - PROCESS | 1651 | Values: 1212.9 1402.6 1408.7 1416.2 1419.5 6834.0 8431.0 8452.5 8458.1 8468.9 7417.4 7685.4 8026.4 8183.5 8277.3 2281.2 2312.7 2312.7 2316.1 2319.9 1774.8 2265.2 2335.8 2355.9 2370.8 2043.4 2119.0 2121.1 2220.3 2294.5 2309.8 2328.2 2333.9 2337.5 2340.7 2004.8 2261.7 2349.7 2353.6 2354.9 8354.2 8376.0 8439.8 8468.2 8471.3 5008.2 5153.7 5161.4 5173.0 5175.7 3342.2 3351.6 3420.0 3540.3 3544.6 1195.9 1202.5 1244.7 1259.4 1259.7 10720.0 10787.4 10821.0 10842.9 10869.2 4375.7 4601.9 4668.0 4681.7 4691.4 9418.6 9448.1 9448.5 9457.6 9472.0 5207.2 5211.3 5219.3 5222.6 5223.1 4587.4 4692.7 4757.4 4799.8 4812.8 3744.9 3773.5 3819.3 3843.1 3860.9 1260.5 1265.8 1273.2 1288.0 1288.9 712.6 771.3 786.2 794.0 834.3 5302.5 5466.8 5781.9 5786.3 5904.8 953.3 993.7 996.4 1014.1 1036.7 3570.8 3691.5 3796.3 3830.4 3830.6 9679.9 10005.9 10013.0 10014.8 10016.4 9694.5 9994.1 10000.0 10099.7 10124.1 7561.7 7829.3 7844.9 7845.9 7862.6 5467.2 5470.2 5529.8 5550.4 5589.3 8975.6 9160.0 9210.7 9269.6 9326.9 9197.3 9248.0 9408.1 9448.6 9527.7 6679.3 6679.5 6787.8 6794.8 6798.3 7771.9 7786.1 7793.1 7800.9 7911.5 6318.4 7055.7 7094.6 7147.7 7150.6 6992.0 7032.1 7066.2 7098.0 7114.5 6281.5 6291.3 6292.4 6356.0 6369.7 4494.4 4818.3 4840.6 4939.3 5017.2 4969.4 4996.6 5038.3 5063.1 5111.5 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4502.98 Median:4905.47 stddev:1335.81 (27.2%) stddev-sans-first:1302.93 07:50:40 INFO - PROCESS | 1651 | Values: 363.4 365.1 373.8 374.6 376.7 5188.3 5260.1 5369.6 5410.8 5414.6 4235.7 4399.6 5250.9 5314.8 5385.4 4132.4 4195.9 4229.8 4234.6 4242.6 3800.0 3891.8 4011.5 4163.7 4250.8 3521.0 4118.1 4197.3 4206.9 4229.5 3775.6 4044.7 4187.6 4204.6 4226.5 3635.9 3721.7 3758.9 3773.7 3786.5 4366.8 5267.4 5279.4 5290.4 5292.4 4870.3 4888.1 4894.6 4900.6 4910.4 4783.3 5383.4 5661.8 5670.2 5753.5 3508.5 3995.6 4081.3 4097.5 4101.7 5856.8 5896.4 5899.6 5931.9 5980.6 3673.4 4034.5 4181.0 4189.6 4196.9 3289.0 3573.2 3598.9 3705.9 4203.6 4811.8 4814.4 4828.9 4830.1 4935.6 4773.0 4839.1 5649.5 5687.9 5717.8 1244.6 1271.5 1311.4 1385.3 1395.7 876.2 911.3 925.1 939.5 992.2 3998.1 4469.8 4981.0 5081.0 5103.6 4367.8 4788.3 5144.8 5342.2 5461.6 4414.5 4517.8 4705.7 4966.9 4977.5 2592.2 2705.1 2776.6 2836.2 2951.2 5316.5 5735.5 5805.4 5827.6 5861.7 4670.3 4963.9 5341.8 5412.1 5754.5 4662.5 5229.4 5500.4 5767.8 5805.0 4407.5 4957.8 5495.8 5517.9 5588.6 4416.1 4513.0 5395.4 5431.5 5455.5 5154.9 5750.9 5771.7 5781.9 5816.8 4008.2 4027.7 4030.4 4118.5 4125.7 4703.6 5133.9 5826.7 5877.9 5884.1 4481.6 4715.9 4883.5 5502.4 5760.8 5347.9 5644.6 5719.7 5723.8 5726.5 4937.8 5327.3 5530.8 5586.5 5605.0 4754.6 5126.5 5268.9 5387.9 5709.0 5497.9 5549.6 5562.5 5586.7 5596.3 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20523.74 Median:19993.03 stddev:29339.12 (146.7%) stddev-sans-first:29383.76 07:50:40 INFO - PROCESS | 1651 | Values: 727.6 740.8 779.6 822.3 823.6 14883.3 15880.9 15909.8 15914.7 15949.4 14409.9 14589.3 14594.0 14607.1 14615.9 560.3 699.8 711.2 865.3 877.7 893.8 900.6 902.1 903.9 906.8 939.3 953.6 953.7 957.5 961.7 949.7 949.7 951.8 951.8 955.8 544.5 560.4 561.9 712.9 717.1 12423.3 12470.9 14529.4 14998.3 15095.0 14093.9 14321.9 14388.1 14407.1 14428.0 11773.7 11790.8 11973.2 12134.0 12148.7 3697.0 3698.4 3853.7 3918.9 3923.5 98985.0 102354.0 102936.0 104076.5 105076.0 11293.0 11354.6 11387.6 11409.5 11447.3 21165.9 23050.3 23235.2 23237.4 23240.0 7732.1 7834.5 7879.4 7938.4 8167.0 4383.4 4385.5 4399.5 4403.1 4452.4 3150.8 3527.8 3613.0 3684.7 3695.8 584.3 618.8 671.1 681.4 685.3 630.5 633.6 646.3 650.7 665.4 10044.5 10366.5 10446.5 10455.0 10501.3 668.6 683.5 695.1 695.2 712.2 4547.7 4938.6 4953.0 4972.4 4984.3 98760.5 103612.0 106119.0 106957.4 107156.0 90444.0 91240.5 92790.5 93824.1 95693.5 77388.0 78202.6 78903.6 80389.0 82378.0 10526.8 10698.3 10879.2 11070.6 11134.6 36373.1 42335.6 43619.8 49734.0 50249.7 61454.1 63704.0 66982.7 67025.3 69522.0 11515.8 13170.7 13340.4 13491.1 13781.2 14710.3 14758.6 14836.0 14852.8 14914.6 13798.0 14218.8 14276.6 14501.1 14522.7 11628.8 13312.2 13557.9 13589.5 14090.7 13339.1 13396.3 13666.2 14095.4 14273.9 11105.9 11285.5 11615.4 11624.8 11640.2 10904.7 11130.1 11357.9 11378.5 11635.9 07:50:40 INFO - PROCESS | 1651 | -------- Summary: end -------- 07:50:40 INFO - PROCESS | 1651 | 07:50:40 INFO - TEST-INFO | 1651: exit 0 07:50:40 INFO - TEST-OK | dromaeo_css | took 1119632ms 07:50:40 INFO - TEST-START | kraken 07:50:40 INFO - operating with platform_type : mac_ 07:50:40 INFO - Initialising browser for kraken test... 07:50:40 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpcuP1ZE/profile http://localhost:49247/getInfo.html) 07:50:43 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 07:50:43 INFO - PROCESS | 1657 | colorDepth:24 07:50:43 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 07:50:43 INFO - PROCESS | 1657 | __metrics 07:50:43 INFO - PROCESS | 1657 | 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:50:43 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:43 INFO - TEST-INFO | 1657: exit 0 07:50:43 INFO - Browser initialized. 07:50:43 INFO - Running cycle 1/1 for kraken test... 07:50:43 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpcuP1ZE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:56 INFO - PROCESS | 1658 | RSS: Main: 235511808 07:50:56 INFO - PROCESS | 1658 | 07:50:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:59 INFO - PROCESS | 1658 | RSS: Main: 287670272 07:50:59 INFO - PROCESS | 1658 | 07:51:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 07:51:02 INFO - PROCESS | 1658 | RSS: Main: 288284672 07:51:02 INFO - PROCESS | 1658 | 07:51:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 07:51:06 INFO - PROCESS | 1658 | RSS: Main: 380727296 07:51:06 INFO - PROCESS | 1658 | 07:51:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 07:51:09 INFO - PROCESS | 1658 | RSS: Main: 282071040 07:51:09 INFO - PROCESS | 1658 | 07:51:11 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:51:12 INFO - PROCESS | 1658 | RSS: Main: 286969856 07:51:12 INFO - PROCESS | 1658 | 07:51:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 07:51:15 INFO - PROCESS | 1658 | RSS: Main: 326909952 07:51:15 INFO - PROCESS | 1658 | 07:51:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 07:51:18 INFO - PROCESS | 1658 | RSS: Main: 329318400 07:51:18 INFO - PROCESS | 1658 | 07:51:21 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 07:51:22 INFO - PROCESS | 1658 | RSS: Main: 328073216 07:51:22 INFO - PROCESS | 1658 | 07:51:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:51:24 INFO - PROCESS | 1658 | RSS: Main: 303144960 07:51:24 INFO - PROCESS | 1658 | 07:51:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:51:27 INFO - PROCESS | 1658 | RSS: Main: 306638848 07:51:27 INFO - PROCESS | 1658 | 07:51:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:51:29 INFO - PROCESS | 1658 | RSS: Main: 308940800 07:51:29 INFO - PROCESS | 1658 | 07:51:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:51:33 INFO - PROCESS | 1658 | RSS: Main: 322600960 07:51:33 INFO - PROCESS | 1658 | 07:51:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:37 INFO - PROCESS | 1658 | RSS: Main: 317202432 07:51:37 INFO - PROCESS | 1658 | 07:51:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 07:51:39 INFO - PROCESS | 1658 | RSS: Main: 361496576 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | __start_tp_report 07:51:39 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 07:51:39 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 07:51:39 INFO - PROCESS | 1658 | |i|pagename|runs| 07:51:39 INFO - PROCESS | 1658 | |0;ai-astar;114;115;114;113;113;114;113;113;113;114 07:51:39 INFO - PROCESS | 1658 | |1;audio-beat-detection;143;110;110;147;111;111;109;109;130;110 07:51:39 INFO - PROCESS | 1658 | |2;audio-dft;186;182;186;184;183;183;183;249;209;182 07:51:39 INFO - PROCESS | 1658 | |3;audio-fft;77;58;58;85;60;58;59;59;74;58 07:51:39 INFO - PROCESS | 1658 | |4;audio-oscillator;87;70;84;69;69;69;81;67;70;84 07:51:39 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;84;89;85;87;84;88;86;88;84 07:51:39 INFO - PROCESS | 1658 | |6;imaging-darkroom;103;95;95;95;94;93;95;94;94;104 07:51:39 INFO - PROCESS | 1658 | |7;imaging-desaturate;85;85;84;87;88;85;86;86;84;85 07:51:39 INFO - PROCESS | 1658 | |8;json-parse-financial;55;54;55;53;55;54;55;53;55;55 07:51:39 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;69;70;72;76;71;70;69;69;70 07:51:39 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;86;85;87;86;109;102;86;86;87;86 07:51:39 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;138;139;143;154;147;140;140;136;179;139 07:51:39 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;208;171;166;181;166;169;169;231;173;174 07:51:39 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;66;65;66;65;66;65;66;64;70 07:51:39 INFO - PROCESS | 1658 | __end_tp_report 07:51:39 INFO - PROCESS | 1658 | __start_cc_report 07:51:39 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1944 07:51:39 INFO - PROCESS | 1658 | __end_cc_report 07:51:39 INFO - PROCESS | 1658 | __startTimestamp1484668299139__endTimestamp 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | ------- Summary: start ------- 07:51:39 INFO - PROCESS | 1658 | Number of tests: 14 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:51:39 INFO - PROCESS | 1658 | Values: 114.0 115.0 114.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:111.00 stddev:15.10 (13.6%) stddev-sans-first:13.29 07:51:39 INFO - PROCESS | 1658 | Values: 143.0 110.0 110.0 147.0 111.0 111.0 109.0 109.0 130.0 110.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:192.70 Median:185.00 stddev:21.38 (11.6%) stddev-sans-first:22.53 07:51:39 INFO - PROCESS | 1658 | Values: 186.0 182.0 186.0 184.0 183.0 183.0 183.0 249.0 209.0 182.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:64.60 Median:59.50 stddev:10.09 (17.0%) stddev-sans-first:9.65 07:51:39 INFO - PROCESS | 1658 | Values: 77.0 58.0 58.0 85.0 60.0 58.0 59.0 59.0 74.0 58.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:75.50 stddev:7.92 (10.5%) stddev-sans-first:7.11 07:51:39 INFO - PROCESS | 1658 | Values: 87.0 70.0 84.0 69.0 69.0 69.0 81.0 67.0 70.0 84.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.87 (2.2%) stddev-sans-first:1.96 07:51:39 INFO - PROCESS | 1658 | Values: 87.0 84.0 89.0 85.0 87.0 84.0 88.0 86.0 88.0 84.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:94.50 stddev:3.91 (4.1%) stddev-sans-first:3.28 07:51:39 INFO - PROCESS | 1658 | Values: 103.0 95.0 95.0 95.0 94.0 93.0 95.0 94.0 94.0 104.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 07:51:39 INFO - PROCESS | 1658 | Values: 85.0 85.0 84.0 87.0 88.0 85.0 86.0 86.0 84.0 85.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.84 (1.5%) stddev-sans-first:0.87 07:51:39 INFO - PROCESS | 1658 | Values: 55.0 54.0 55.0 53.0 55.0 54.0 55.0 53.0 55.0 55.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:2.77 (4.0%) stddev-sans-first:2.24 07:51:39 INFO - PROCESS | 1658 | Values: 65.0 69.0 70.0 72.0 76.0 71.0 70.0 69.0 69.0 70.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:86.00 stddev:8.35 (9.7%) stddev-sans-first:8.73 07:51:39 INFO - PROCESS | 1658 | Values: 86.0 85.0 87.0 86.0 109.0 102.0 86.0 86.0 87.0 86.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:141.50 stddev:12.89 (9.1%) stddev-sans-first:13.38 07:51:39 INFO - PROCESS | 1658 | Values: 138.0 139.0 143.0 154.0 147.0 140.0 140.0 136.0 179.0 139.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:173.50 stddev:21.55 (12.4%) stddev-sans-first:20.49 07:51:39 INFO - PROCESS | 1658 | Values: 208.0 171.0 166.0 181.0 166.0 169.0 169.0 231.0 173.0 174.0 07:51:39 INFO - PROCESS | 1658 | 07:51:39 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.63 (2.5%) stddev-sans-first:1.69 07:51:39 INFO - PROCESS | 1658 | Values: 67.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 64.0 70.0 07:51:39 INFO - PROCESS | 1658 | -------- Summary: end -------- 07:51:39 INFO - PROCESS | 1658 | 07:51:40 INFO - TEST-INFO | 1658: exit 0 07:51:40 INFO - TEST-OK | kraken | took 59387ms 07:51:40 INFO - SUITE-END | took 1179s 07:51:40 INFO - Completed test suite (00:19:39) 07:51:40 INFO - javascript benchmark 07:51:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.8993830185086, 3357.6138744044442, 3361.8487168077436, 3371.578552680915, 3427.126082848873, 5606.719664016803, 5650.74571644276, 5703.543716502681, 5768.365479797224, 5791.0, 5681.233033540481, 5756.597038207327, 5842.503387212081, 5880.852978675535, 5897.616654917428, 5153.896922061556, 5156.74216289184, 5180.171172612364, 5250.028744682227, 5283.841484755463, 5355.705436201008, 5363.9463605363835, 5369.0, 5377.7580008899695, 5416.972915135439, 5144.305518754958, 5242.501962313574, 5261.631685781997, 5274.709890956015, 5307.840764777044, 5156.2007888776925, 5179.249008893689, 5234.790608375661, 5242.082635538765, 5244.449332820075, 5234.92147617786, 5244.763985620656, 5267.736613169364, 5268.209768534751, 5282.260483532308, 5693.886122277573, 5738.454846789548, 5742.368339482696, 5746.367899531048, 5763.193152958589, 6171.87656246877, 6174.84562885927, 6285.937140628626, 6297.937020629826, 6306.337834527354, 5911.320198177222, 6213.0, 6267.0, 6275.811725648238, 6315.715792789336, 5790.855228619234, 5838.380204273378, 5851.502622277069, 5864.266966629171, 5896.882062358814, 6202.162708034448, 6238.781642642576, 6270.717817698214, 6281.403266689657, 6299.622022678654, 6119.571629985947, 6143.232095988002, 6153.661548614869, 6194.442500175006, 6202.038684003986, 6122.947104152868, 6291.96854015727, 6297.055441683784, 6298.937010629835, 6299.275583307886, 6083.878322433527, 6135.631862088289, 6169.167162433104, 6171.722272497748, 6172.259328880563, 6237.719302631302, 6277.5605707600025, 6290.496760259169, 6298.527610429236, 6300.779472718433, 4043.7169398141846, 4927.162382394929, 4948.455669876311, 5014.2979982802435, 5047.570956468668, 4441.400410944546, 4443.37792709021, 4454.465464144323, 4467.709598876063, 4533.161365147458, 5895.970520147372, 5900.586958912921, 5915.585908986416, 5923.496502797224, 5960.940390596125, 6300.936990630126, 6304.8423789404715, 6306.4639505642535, 6309.652969086653, 6313.873722525524, 5690.089585666274, 5699.914501282484, 5746.88506229873, 5789.8552536186935, 5887.941120588825, 5451.509364157245, 5459.5359394451125, 5502.724863756796, 5525.0, 5541.889162216733, 5257.710825904612, 6325.557210995186, 6346.7461301549265, 6351.96824015877, 6367.681615919279, 5533.6126471148245, 6106.096658337741, 6216.7824126155365, 6294.464970477561, 6302.3067462578165, 6233.127362169209, 6250.593711408744, 6263.78076767311, 6359.96820015897, 6374.681265936777, 6243.469305109116, 6263.311035785969, 6266.843328916813, 6270.49836013127, 6290.937090629035, 5263.394709608444, 6231.283402408781, 6245.250569931637, 6281.560290779602, 6298.84252893663, 4957.256411538298, 6018.307894592178, 6087.117367981707, 6087.147799308012, 6137.877242455215, 6144.969275153596, 6145.125736650186, 6151.200343955257, 6158.876822463615, 6170.0, 5834.591578589458, 5930.881382372415, 5941.079132734433, 5965.880682386415, 6071.878562428815, 6094.024956007018, 6115.0, 6122.001753127661, 6123.343628574205, 6147.477464415396, 5840.883182336414, 6032.276126864805, 6033.969830150997, 6043.697815109315, 6080.574359794772], "value": 5717.62318533863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.9720518166317, 498.48157915767626, 504.1958076867396, 507.30499216073974, 521.4576840086311, 30006.549901751492, 39388.80305598472, 41128.58871411293, 41128.79435602818, 43133.0, 37410.0647483813, 42542.93642658927, 42882.0, 42956.78521607396, 42958.35562466558, 8221.013478382603, 9090.090990900922, 9438.480883551401, 9438.575264113097, 9477.383970041925, 7118.644067796616, 11028.724281892937, 11273.718157046058, 11294.774104517905, 11507.59723409681, 11300.943495282512, 11365.374904380256, 11385.08919286455, 11387.54449822006, 11399.430028498542, 8261.793455163668, 8467.0, 11267.492962816652, 11339.716507087307, 11374.146938979567, 8462.449940753831, 8512.021117571496, 8948.776280592972, 11111.666650000512, 11148.721281967935, 40194.0, 40514.39228411576, 40568.0, 40620.0, 40745.79627101846, 4011.5988401159652, 4038.9798051009852, 4049.1496785675045, 4076.8369265229353, 4088.4480595119576, 30451.086467406014, 31122.688773112204, 31199.688003119903, 31244.687553124404, 31679.366412671618, 3160.541721450377, 3163.43058249515, 3179.666135055832, 3196.216926852936, 3290.588676415448, 436084.0, 437014.0, 437180.0, 439127.0, 439523.0, 57730.42269577335, 58164.0, 58176.0, 58238.70880645655, 58293.8341233173, 60960.085598716054, 61280.77438451206, 61283.387166127766, 61288.0, 61355.0, 15515.922420388051, 16063.598410039609, 16075.276612552463, 16094.19529023544, 16139.031658100552, 11090.889091109148, 11406.885931140583, 12312.322822244863, 12498.0, 12588.748225035448, 15221.31504082319, 15233.0, 15292.541223763305, 15303.846961530242, 15408.691826163415, 6269.529785266032, 6274.529410294155, 6306.959351707009, 6342.365763423713, 6349.492040636738, 795.7135431244748, 824.2416976381743, 835.0730688935276, 891.4517571693361, 915.839728047589, 29072.41855162885, 29927.551086733718, 30203.697963020528, 30446.086617401514, 30744.0, 1020.3061917895753, 1069.887661795516, 1081.7674200047027, 1093.688298834844, 1135.1202817816259, 12591.433385497674, 13481.528146514825, 13941.0, 14256.501022464165, 14272.785908211385, 615042.8495715075, 618169.0, 618303.0, 619082.9045854833, 620497.8975105096, 49895.25157122646, 50067.0, 50105.0, 50150.49849501458, 50201.0, 1411.7247136808223, 1421.3319739722315, 1443.364919435466, 1450.2966061460183, 1455.4760286296712, 25495.107671231417, 26252.60621090647, 26867.731322687305, 26870.731292687604, 27430.725692742817, 36983.44524832076, 41122.794386027876, 44544.0, 44577.777111114236, 44667.55332446634, 550131.0, 551473.0, 552655.0, 554707.0, 555987.0, 21169.894150529766, 21607.703537787784, 21652.783472165076, 23574.646380303966, 23890.924908378816, 40696.59303406928, 40941.59058409378, 41480.79259603683, 42899.568034557786, 43054.13891722211, 34003.0, 35356.0, 35373.64626353703, 36190.009549475035, 36330.63669363378, 35421.04105425294, 35543.46684799782, 35996.64003360038, 36226.73206437762, 36364.45453318255, 34393.0, 34618.94168520549, 35574.46638300376, 35681.82159089188, 36670.266594668494, 29995.70004299929, 31542.526862097548, 31563.89526366658, 31652.050438486884, 31690.683093168773, 19631.411057668294, 23056.38605297613, 23653.52692946166, 24211.757882421654, 24356.372289264982], "value": 19087.740208319017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2568040959313, 395.4680954116713, 400.079816422229, 411.6727201874509, 427.3653624367813, 13958.162510249393, 15867.127307998055, 18047.4585762427, 20526.897365513152, 21043.36869893902, 21115.683264751002, 21337.466563335925, 21491.0, 21845.344639660794, 21948.780512194873, 5777.653340799566, 5802.796902108437, 5944.435278648543, 6004.309504406983, 6061.272647282332, 4174.749515029108, 5437.13005919053, 5464.153056276264, 5562.9443705562835, 5588.441155884399, 4358.171947329997, 4381.101874115799, 4383.736975781463, 5995.836904616138, 6654.367835055662, 5683.54531637468, 6618.834529136762, 6627.73489060437, 6633.900491492632, 6643.568168069109, 5052.444231134572, 5294.602904782157, 5348.839534813962, 5391.272178255964, 5394.136938089926, 13297.601071967856, 13321.533746318832, 13359.799603005962, 13528.661783455493, 13536.59390218295, 2544.185860524633, 2629.6581444412295, 2698.2310041638234, 2699.0553306342817, 2701.081632245046, 9656.324057315991, 10229.897701022968, 14055.64860878476, 14782.778258326134, 15649.843501564952, 1759.683257013737, 1787.7765279340083, 1795.9640807183914, 1797.9370722024796, 1802.78366596008, 94118.52940735321, 128499.0, 129917.0, 133155.33422332924, 133461.0, 10033.548490317808, 11081.556737730562, 11214.943925280484, 11370.97661210495, 11546.59586914454, 15163.545093646988, 15169.544913652388, 15172.620684482756, 15186.696266074616, 15214.315355809014, 8202.097769245378, 8428.578571071423, 8452.704155354657, 8600.526971016528, 8679.262262707614, 8249.29880960125, 8252.0, 8257.339412846957, 8365.498070115813, 8419.326453883674, 4537.160625284333, 4621.716356189204, 4633.397658304399, 4707.599854012447, 4745.264484004984, 1971.9309824156085, 2009.2063634864146, 2031.3296612117965, 2033.2070492507933, 2037.2564014134734, 1013.0578561937469, 1020.3316827478013, 1031.8297480915714, 1040.2731465766942, 1052.032130439997, 20396.898015510124, 20765.688514672293, 20785.0, 21062.262820801505, 21144.47138821511, 1024.5491983527372, 1032.3599368391644, 1034.2294990232326, 1073.7852429514128, 1084.479449864054, 10644.840327395095, 10966.451677416257, 11026.669199924016, 11046.33721976668, 11140.721481962853, 591617.0, 621309.8934505299, 706855.0, 730161.1427485669, 733252.0, 103326.0, 113131.43434282776, 143455.0, 145306.74279200743, 153096.0, 449.77286470332274, 459.59325996493345, 473.16722568280073, 473.644766425188, 474.9833755818599, 10065.748356291151, 10228.948855255676, 10890.074343680875, 11445.885541144482, 11539.115221194701, 56448.15327770005, 59582.0, 59896.10155847753, 60418.697906511945, 61158.694206528686, 86659.0, 90197.54901225452, 91170.0, 92460.53769731108, 92605.5369723147, 7799.688012479437, 8189.754307370788, 8319.459235149696, 8482.872756908775, 8780.209781119729, 7536.9246307538415, 9716.659916902874, 10825.296355736851, 13055.086143969831, 13078.0, 10080.092791648787, 10991.670249892515, 11052.115830733683, 11676.06591472697, 11780.234284771463, 9350.0, 10753.408562529135, 11654.0, 11808.468618911998, 11843.881561184278, 10342.32774869631, 11020.0, 11344.886551134383, 11616.0, 11940.0, 8441.113683063435, 8445.78885527842, 8575.228229459379, 8610.78473038154, 8682.39985209549, 9575.760605984906, 11054.723631909266, 11595.768084638428, 11747.236429632047, 11795.233309834834], "value": 9282.45922167545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.9332886691234, 1402.57221547428, 1408.6830463145786, 1416.157386355119, 1419.4747943260995, 6833.965830170849, 8431.0, 8452.535110568931, 8458.111898250687, 8468.915310846889, 7417.443691723115, 7685.385169186466, 8026.43814932955, 8183.508989460636, 8277.337812974962, 2281.235786011688, 2312.7224733031976, 2312.7340355859124, 2316.131450705985, 2319.8724070176136, 1774.8491378232866, 2265.150568536799, 2335.7547457516885, 2355.858648481088, 2370.8103351731907, 2043.4278402047375, 2118.9788102119014, 2121.0561300221407, 2220.322801545528, 2294.4837411582425, 2309.7805708457668, 2328.196772113618, 2333.9066437342485, 2337.4623836517694, 2340.719113706366, 2004.8195662390308, 2261.6607508873635, 2349.706286714161, 2353.5645905507363, 2354.85870847748, 8354.248117669438, 8375.958120209421, 8439.83120337596, 8468.153184681543, 8471.279941205004, 5008.223725322581, 5153.6907785532985, 5161.380634323905, 5173.0, 5175.741212939376, 3342.242649813889, 3351.631320554737, 3420.0423881313022, 3540.345036168317, 3544.61009288978, 1195.8564972203305, 1202.4769225386985, 1244.7386048929645, 1259.3514340114848, 1259.6850787303174, 10720.0, 10787.406692631903, 10821.0, 10842.891571084347, 10869.184811139117, 4375.7155784873885, 4601.861944141681, 4668.043051174501, 4681.695689780154, 4691.413573303337, 9418.62325506972, 9448.102430269113, 9448.527573621292, 9457.621695132255, 9471.952640236756, 5207.218917162456, 5211.296474975906, 5219.295395121686, 5222.582193424517, 5223.112070947948, 4587.38070360497, 4692.724028846007, 4757.429108507002, 4799.832005879777, 4812.783424745895, 3744.9063773405883, 3773.4905787718308, 3819.3316169670197, 3843.0584506796013, 3860.8841734748003, 1260.4832018872219, 1265.7974724044109, 1273.2042473454092, 1287.9678008049686, 1288.903332250085, 712.5902606001466, 771.2827070824187, 786.1745167574024, 793.984120317602, 834.3408707121428, 5302.549283310885, 5466.781328746805, 5781.855453613609, 5786.276715410574, 5904.76380944766, 953.323140570189, 993.732990437184, 996.4270544436978, 1014.1075853249241, 1036.6682661548232, 3570.785752854837, 3691.5016472775833, 3796.2597293527497, 3830.3871380578976, 3830.578636349999, 9679.9032009679, 10005.949970250102, 10013.048760367754, 10014.799704006025, 10016.399016058915, 9694.466804325688, 9994.050565196294, 10000.0, 10099.697009089592, 10124.088832005154, 7561.735339263099, 7829.295363417434, 7844.882326765103, 7845.921540784633, 7862.646180921758, 5467.20725494809, 5470.17947307907, 5529.778808847762, 5550.389457159628, 5589.273394458694, 8975.640974361213, 9159.954200228956, 9210.723678289662, 9269.629214831331, 9326.860097098684, 9197.264218862341, 9247.953760231425, 9408.106229908148, 9448.622055117994, 9527.714168574954, 6679.265280819009, 6679.4990375721045, 6787.796366109024, 6794.830129246809, 6798.252192258947, 7771.883421748791, 7786.143524212445, 7793.06483222017, 7800.882986755089, 7911.5253084815095, 6318.4313411793155, 7055.717771289091, 7094.64526773649, 7147.678354473957, 7150.6424678764815, 6992.0, 7032.12098487689, 7066.222715501188, 7098.041764361951, 7114.537555058904, 6281.466075383643, 6291.339409361951, 6292.370762923671, 6356.0, 6369.681515924278, 4494.438195225597, 4818.301346304696, 4840.636952228527, 4939.308496810521, 5017.197248440232, 4969.403671559291, 4996.575291100297, 5038.269450929668, 5063.088644044107, 5111.539961403491], "value": 4384.355736486944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.44755970924194, 365.1364522903333, 373.7888093227326, 374.6422166830677, 376.67794036099133, 5188.2995795567585, 5260.132078207101, 5369.610523317126, 5410.83767486975, 5414.646338415396, 4235.724677895934, 4399.582039706231, 5250.894982100355, 5314.76083576239, 5385.380681221661, 4132.400801883732, 4195.895102622444, 4229.830806767725, 4234.649769377994, 4242.639375653073, 3799.96701764556, 3891.835735762735, 4011.458453108822, 4163.666906647476, 4250.83102146909, 3520.9789161143367, 4118.114605359847, 4197.265478541259, 4206.852760153395, 4229.471316085489, 3775.5846856845724, 4044.69664775143, 4187.581241875803, 4204.600562946515, 4226.450561427026, 3635.8545658173643, 3721.6836568891677, 3758.924821503582, 3773.660370566662, 3786.5266841644793, 4366.8034938427845, 5267.3679158500845, 5279.392869819943, 5290.418054014055, 5292.444293349181, 4870.342503761982, 4888.071266459361, 4894.580571634222, 4900.558949694509, 4910.37295047148, 4783.282507623884, 5383.353997520284, 5661.801836935729, 5670.193254339088, 5753.453421924911, 3508.5088087667746, 3995.640392364672, 4081.3265811141127, 4097.549269580344, 4101.692373072032, 5856.824295271149, 5896.410358964112, 5899.616524925909, 5931.940680593182, 5980.581359304894, 3673.412254039341, 4034.495688038995, 4180.979095104566, 4189.601987811153, 4196.916061678749, 3288.9835550822095, 3573.1960308930284, 3598.892033239007, 3705.870294539732, 4203.616089048284, 4811.759412029384, 4814.398200224972, 4828.903421931542, 4830.058138662927, 4935.580475659609, 4772.952270477251, 4839.127661271036, 5649.485978739422, 5687.886242275132, 5717.771289148387, 1244.595506460404, 1271.4786937355639, 1311.4033114932683, 1385.3350391811987, 1395.6720170759863, 876.1851478125404, 911.293747345799, 925.1165137293868, 939.5155654066558, 992.2211064314623, 3998.140399814054, 4469.754163521037, 4980.950190498121, 5081.034603425337, 5103.566196873233, 4367.803448844746, 4788.281757736368, 5144.803748214331, 5342.225377320345, 5461.617686761968, 4414.4702635683925, 4517.81928722854, 4705.717656940595, 4966.900661986812, 4977.452480227172, 2592.2223333000024, 2705.0937935791335, 2776.6112744215825, 2836.163331817119, 2951.2474319048506, 5316.548093412103, 5735.4551317624755, 5805.41658961758, 5827.59206855516, 5861.706914654335, 4670.322803193518, 4963.851084467472, 5341.813036543703, 5412.107002344648, 5754.482096611325, 4662.53374662531, 5229.424763276036, 5500.4499550044675, 5767.798127065533, 5804.970975145097, 4407.493138289138, 4957.801687932442, 5495.752691128829, 5517.917231241615, 5588.552915766648, 4416.072624748838, 4512.984578469818, 5395.406505284337, 5431.511163995259, 5455.454454554513, 5154.8969020620125, 5750.856228594319, 5771.7402716877, 5781.94218057814, 5816.76732930678, 4008.2183974124764, 4027.7180597357906, 4030.3954406839207, 4118.487722489339, 4125.711200216077, 4703.647226457961, 5133.948660513496, 5826.650400975955, 5877.941220587911, 5884.146798714248, 4481.624738888394, 4715.929261061018, 4883.536064073907, 5502.449755024466, 5760.819032098493, 5347.919781203207, 5644.569013324521, 5719.685417301922, 5723.828285151286, 5726.5418766499415, 4937.790436216488, 5327.334083239595, 5530.778768849362, 5586.525145362527, 5605.0, 4754.572088512051, 5126.512981266774, 5268.947310526845, 5387.919181212206, 5709.0, 5497.862553436036, 5549.639273447213, 5562.527185189304, 5586.720663966704, 5596.3284405871555], "value": 4098.907407695361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.5780047572405, 740.7628662743804, 779.5829231361223, 822.325692931796, 823.6458322921144, 14883.255837208137, 15880.920595397036, 15909.761353579677, 15914.68170636588, 15949.441769538054, 14409.92795036026, 14589.270536473186, 14593.9784215105, 14607.050541714782, 14615.926920365384, 560.2576586023515, 699.7585832887646, 711.1501755402296, 865.2558799432483, 877.6840337478519, 893.8033632600817, 900.5992333411634, 902.0843843498822, 903.9005709371963, 906.755176102452, 939.3330735178032, 953.5661274120258, 953.7091187187905, 957.5308099031494, 961.7307153996892, 949.6628696812601, 949.7008442340641, 951.7953639967441, 951.8477043672979, 955.7897262602252, 544.5425842292453, 560.3611882454006, 561.9494245517882, 712.8538649576876, 717.096458462336, 12423.31671758053, 12470.875291247063, 14529.418823247057, 14998.325075371635, 15095.0, 14093.85906140946, 14321.928390358085, 14388.136711797326, 14407.135571865721, 14427.990040697156, 11773.705657358549, 11790.79118480906, 11973.221740586834, 12134.029277657766, 12148.696282593006, 3697.038769919813, 3698.408254679265, 3853.730238883279, 3918.9412158817354, 3923.5487918889407, 98985.0, 102354.0, 102935.97064029338, 104076.47961760142, 105076.0, 11293.0, 11354.602588909349, 11387.601433949772, 11409.543618255342, 11447.25592836463, 21165.89417052936, 23050.308490745305, 23235.186768463023, 23237.41906452352, 23240.0, 7732.110807257125, 7834.4907581007055, 7879.369650427952, 7938.444308898322, 8166.959165204136, 4383.430154079949, 4385.539518350591, 4399.494058183286, 4403.137960325814, 4452.4211852458975, 3150.763692723055, 3527.8412471438846, 3612.9638703612627, 3684.6868016218386, 3695.796731179757, 584.3455330030393, 618.7648693496443, 671.1375881991618, 681.3731367142241, 685.2975699907635, 630.489976506265, 633.6071635585874, 646.3407324528954, 650.7364517370472, 665.4443539644354, 10044.547995340226, 10366.481675916173, 10446.477676116163, 10455.0, 10501.264911456277, 668.582136164897, 683.4771399879096, 695.1380288442296, 695.2317688953734, 712.237905441173, 4547.704399214041, 4938.580220681282, 4952.975235123801, 4972.353594032825, 4984.277279794482, 98760.50619747, 103612.0, 106119.0, 106957.39563906548, 107156.0, 90444.0, 91240.5437972806, 92790.53604731933, 93824.0617593829, 95693.5215323919, 77388.0, 78202.6089869547, 78903.60548197222, 80388.99027524475, 82378.0, 10526.789464210826, 10698.251122421356, 10879.23845330851, 11070.612528561462, 11134.615863218998, 36373.09067273234, 42335.576644233166, 43619.78190109029, 49734.0, 50249.74875125601, 61454.0781888281, 63704.0, 66982.66034679182, 67025.32436689122, 69522.0, 11515.769684606094, 13170.736585268049, 13340.399682014138, 13491.123076999964, 13781.173129612256, 14710.264486775832, 14758.631034223801, 14836.0, 14852.7772083421, 14914.552563423114, 13798.0, 14218.786718199442, 14276.643718846693, 14501.129932204101, 14522.709545809235, 11628.76742465129, 13312.183940052626, 13557.93221033928, 13589.52436664712, 14090.718185636024, 13339.132956357806, 13396.330183490982, 13666.248356340497, 14095.365708543346, 14273.928630357197, 11105.944470277596, 11285.548578057114, 11615.361155136548, 11624.82562761576, 11640.185187036826, 10904.727381815517, 11130.109591232844, 11357.886421135683, 11378.54485820591, 11635.941820290844], "value": 7581.331253428486, "unit": "score"}], "name": "dromaeo_css", "value": 7188.963774045092, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 110.0, 147.0, 111.0, 111.0, 109.0, 109.0, 130.0, 110.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 186.0, 184.0, 183.0, 183.0, 183.0, 249.0, 209.0, 182.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 58.0, 85.0, 60.0, 58.0, 59.0, 59.0, 74.0, 58.0], "value": 64.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 84.0, 69.0, 69.0, 69.0, 81.0, 67.0, 70.0, 84.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 85.0, 87.0, 84.0, 88.0, 86.0, 88.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 95.0, 95.0, 95.0, 94.0, 93.0, 95.0, 94.0, 94.0, 104.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 87.0, 88.0, 85.0, 86.0, 86.0, 84.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 55.0, 54.0, 55.0, 53.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 70.0, 72.0, 76.0, 71.0, 70.0, 69.0, 69.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 86.0, 109.0, 102.0, 86.0, 86.0, 87.0, 86.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 143.0, 154.0, 147.0, 140.0, 140.0, 136.0, 179.0, 139.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 171.0, 166.0, 181.0, 166.0, 169.0, 169.0, 231.0, 173.0, 174.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 64.0, 70.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1439.6000000000001, "alertThreshold": 2.0}]} 07:51:40 INFO - Return code: 0 07:51:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:40 ERROR - # TBPL SUCCESS # 07:51:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:40 INFO - 2017-01-17 07:51:40.435 screenresolution[1662:11565] starting screenresolution argv=screenresolution get 07:51:40 INFO - 2017-01-17 07:51:40.437 screenresolution[1662:11565] Display 0: 1600x1200x32@60 07:51:40 INFO - 2017-01-17 07:51:40.444 screenresolution[1663:11568] starting screenresolution argv=screenresolution list 07:51:40 INFO - Available Modes on Display 0 07:51:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:40 INFO - Intel Iris: 07:51:40 INFO - Chipset Model: Intel Iris 07:51:40 INFO - Type: GPU 07:51:40 INFO - Bus: Built-In 07:51:40 INFO - VRAM (Dynamic, Max): 1536 MB 07:51:40 INFO - Vendor: Intel (0x8086) 07:51:40 INFO - Device ID: 0x0a2e 07:51:40 INFO - Revision ID: 0x0009 07:51:40 INFO - Displays: 07:51:40 INFO - Display: 07:51:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:40 INFO - Display Serial Number: 1600x1200 60 07:51:40 INFO - Main Display: Yes 07:51:40 INFO - Mirror: Off 07:51:40 INFO - Online: Yes 07:51:40 INFO - Rotation: Supported 07:51:40 INFO - Return code: 0 07:51:40 INFO - Running post-action listener: _resource_record_post_action 07:51:40 INFO - [mozharness: 2017-01-17 15:51:40.685337Z] Finished run-tests step (success) 07:51:40 INFO - Running post-run listener: _resource_record_post_run 07:51:40 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32353280; Write bytes: 553368064; Read time: 193; Write time: 1696 07:51:40 INFO - TinderboxPrint: CPU usage
53.8% 07:51:40 INFO - TinderboxPrint: I/O read bytes / time
32,353,280 / 193 07:51:40 INFO - TinderboxPrint: I/O write bytes / time
553,368,064 / 1,696 07:51:40 INFO - TinderboxPrint: CPU idle
2,219.7 (46.2%) 07:51:40 INFO - TinderboxPrint: CPU system
959.2 (20.0%) 07:51:40 INFO - TinderboxPrint: CPU user
1,626.8 (33.9%) 07:51:40 INFO - TinderboxPrint: Swap in / out
279,891,968 / 0 07:51:40 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252836352; Write bytes: 252665856; Read time: 18212; Write time: 552 07:51:40 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 28957696; Write bytes: 299330048; Read time: 170; Write time: 1138 07:51:41 INFO - Running post-run listener: _upload_blobber_files 07:51:41 INFO - Blob upload gear active. 07:51:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:41 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:51:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:51:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:51:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:42 INFO - (blobuploader) - INFO - Done attempting. 07:51:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:43 INFO - (blobuploader) - INFO - Done attempting. 07:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:44 INFO - (blobuploader) - INFO - Done attempting. 07:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:46 INFO - (blobuploader) - INFO - Done attempting. 07:51:46 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:46 INFO - Return code: 0 07:51:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5f5c8f0254c245087cfdfbc617356ec626f8173052c6f1ee607ba6d0b51279e5f2da5fe5f90a645208bfa7346c1f99d94abab5ace4fc0eae34c52633da63f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0976aa013438aa2555c29b73fad0f3fbc7538098c9c9d9e4e09f70c259dd2c6a69331d1c828057eb4c0e8cd8fb7296801a560926e2a2d35852166afd46916fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c516c8f7bf0c4ec8cdf053954a642c92f7ec3cad2c336dbe54f08ff7238e0e5c67e0e93dd5f62707967a50b946ebd307691b528a23b8186d2397038dc0061d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86c3c3428db958613ee9b711e8b48ae0f01340ffb56ebf2108fe0bae0f7bd365267e09ba278ea4f43686621eaacfef7cea43f9b0af5acca789bc1577373ba662"} 07:51:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:46 INFO - Contents: 07:51:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5f5c8f0254c245087cfdfbc617356ec626f8173052c6f1ee607ba6d0b51279e5f2da5fe5f90a645208bfa7346c1f99d94abab5ace4fc0eae34c52633da63f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0976aa013438aa2555c29b73fad0f3fbc7538098c9c9d9e4e09f70c259dd2c6a69331d1c828057eb4c0e8cd8fb7296801a560926e2a2d35852166afd46916fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c516c8f7bf0c4ec8cdf053954a642c92f7ec3cad2c336dbe54f08ff7238e0e5c67e0e93dd5f62707967a50b946ebd307691b528a23b8186d2397038dc0061d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86c3c3428db958613ee9b711e8b48ae0f01340ffb56ebf2108fe0bae0f7bd365267e09ba278ea4f43686621eaacfef7cea43f9b0af5acca789bc1577373ba662"} 07:51:46 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:46 INFO - Copying logs to upload dir... 07:51:46 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.082963 ========= master_lag: 0.97 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-17 07:51:47.890460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:47.894059) ========= 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.E5U7H2Q240/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.UfQOgZe3xL/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5f5c8f0254c245087cfdfbc617356ec626f8173052c6f1ee607ba6d0b51279e5f2da5fe5f90a645208bfa7346c1f99d94abab5ace4fc0eae34c52633da63f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0976aa013438aa2555c29b73fad0f3fbc7538098c9c9d9e4e09f70c259dd2c6a69331d1c828057eb4c0e8cd8fb7296801a560926e2a2d35852166afd46916fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c516c8f7bf0c4ec8cdf053954a642c92f7ec3cad2c336dbe54f08ff7238e0e5c67e0e93dd5f62707967a50b946ebd307691b528a23b8186d2397038dc0061d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86c3c3428db958613ee9b711e8b48ae0f01340ffb56ebf2108fe0bae0f7bd365267e09ba278ea4f43686621eaacfef7cea43f9b0af5acca789bc1577373ba662"} build_url:https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/J-xXnEkfTzmpme_BlJX-AQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5f5c8f0254c245087cfdfbc617356ec626f8173052c6f1ee607ba6d0b51279e5f2da5fe5f90a645208bfa7346c1f99d94abab5ace4fc0eae34c52633da63f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0976aa013438aa2555c29b73fad0f3fbc7538098c9c9d9e4e09f70c259dd2c6a69331d1c828057eb4c0e8cd8fb7296801a560926e2a2d35852166afd46916fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c516c8f7bf0c4ec8cdf053954a642c92f7ec3cad2c336dbe54f08ff7238e0e5c67e0e93dd5f62707967a50b946ebd307691b528a23b8186d2397038dc0061d0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86c3c3428db958613ee9b711e8b48ae0f01340ffb56ebf2108fe0bae0f7bd365267e09ba278ea4f43686621eaacfef7cea43f9b0af5acca789bc1577373ba662"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:47.928772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:47.929090) ========= 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.E5U7H2Q240/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.UfQOgZe3xL/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 07:51:47.977525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 07:51:47.977844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 07:51:47.978193) ========= ========= Total master_lag: 1.11 =========