builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0381 starttime: 1490517221.38 results: success (0) buildid: 20170326004006 builduid: d918ae29df214bf696bf8b8d7327c10a revision: 997b98cce1aebf76641e14c79ac250cdb147041c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.376191) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.377332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.377614) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.404861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.405283) ========= 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.Ir444pvT8P/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.kghmRfQcjA/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-26 01:33:41-- 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% 18.5M=0.001s 2017-03-26 01:33:42 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.478388 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.984329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:41.984846) ========= 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.Ir444pvT8P/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.kghmRfQcjA/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.041649 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:42.049701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:42.050075) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 997b98cce1aebf76641e14c79ac250cdb147041c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 997b98cce1aebf76641e14c79ac250cdb147041c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ir444pvT8P/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.kghmRfQcjA/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-26 01:33:42,306 truncating revision to first 12 chars 2017-03-26 01:33:42,306 Setting DEBUG logging. 2017-03-26 01:33:42,306 attempt 1/10 2017-03-26 01:33:42,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/997b98cce1ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-26 01:33:42,967 unpacking tar archive at: mozilla-aurora-997b98cce1ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953780 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:43.028235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:43.028544) ========= script_repo_revision: 997b98cce1aebf76641e14c79ac250cdb147041c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:43.030066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:43.030359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-26 01:33:43.050147) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-26 01:33:43.050471) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ir444pvT8P/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.kghmRfQcjA/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:33:43 INFO - MultiFileLogger online at 20170326 01:33:43 in /builds/slave/test 01:33:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:33:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:33:43 INFO - {'append_to_log': False, 01:33:43 INFO - 'base_work_dir': '/builds/slave/test', 01:33:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:33:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:33:43 INFO - 'branch': 'Mozilla-Aurora', 01:33:43 INFO - 'buildbot_json_path': 'buildprops.json', 01:33:43 INFO - 'config_files': ('talos/mac_config.py',), 01:33:43 INFO - 'default_actions': ('clobber', 01:33:43 INFO - 'read-buildbot-config', 01:33:43 INFO - 'download-and-extract', 01:33:43 INFO - 'populate-webroot', 01:33:43 INFO - 'create-virtualenv', 01:33:43 INFO - 'install', 01:33:43 INFO - 'run-tests'), 01:33:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:33:43 INFO - 'download_minidump_stackwalk': True, 01:33:43 INFO - 'download_symbols': 'ondemand', 01:33:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:33:43 INFO - 'tooltool.py': '/tools/tooltool.py', 01:33:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:33:43 INFO - '/tools/misc-python/virtualenv.py')}, 01:33:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:33:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:33:43 INFO - 'gecko_profile': False, 01:33:43 INFO - 'gecko_profile_interval': 0, 01:33:43 INFO - 'installer_path': 'installer.exe', 01:33:43 INFO - 'log_level': 'info', 01:33:43 INFO - 'log_name': 'talos', 01:33:43 INFO - 'log_to_console': True, 01:33:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:33:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:33:43 INFO - 'opt_config_files': (), 01:33:43 INFO - 'pip_index': False, 01:33:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:43 INFO - 'cmd': ('bash', 01:33:43 INFO - '-c', 01:33:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:43 INFO - 'enabled': True, 01:33:43 INFO - 'halt_on_failure': False, 01:33:43 INFO - 'name': 'check_screen_resolution'},), 01:33:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:43 INFO - 'cmd': ('bash', 01:33:43 INFO - '-c', 01:33:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:43 INFO - 'enabled': True, 01:33:43 INFO - 'halt_on_failure': False, 01:33:43 INFO - 'name': 'check_screen_resolution'},), 01:33:43 INFO - 'run_cmd_checks_enabled': True, 01:33:43 INFO - 'suite': 'dromaeojs', 01:33:43 INFO - 'system_bits': '32', 01:33:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:33:43 INFO - 'title': 't-yosemite-r7-0381', 01:33:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:33:43 INFO - 'use_talos_json': True, 01:33:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:33:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:33:43 INFO - 'work_dir': 'build'} 01:33:43 INFO - [mozharness: 2017-03-26 08:33:43.413729Z] Running clobber step. 01:33:43 INFO - Running pre-action listener: _resource_record_pre_action 01:33:43 INFO - Running main action method: clobber 01:33:43 INFO - rmtree: /builds/slave/test/build 01:33:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:33:45 INFO - Running post-action listener: _resource_record_post_action 01:33:45 INFO - [mozharness: 2017-03-26 08:33:45.956444Z] Finished clobber step (success) 01:33:45 INFO - [mozharness: 2017-03-26 08:33:45.956632Z] Running read-buildbot-config step. 01:33:45 INFO - Running pre-action listener: _resource_record_pre_action 01:33:45 INFO - Running main action method: read_buildbot_config 01:33:45 INFO - Using buildbot properties: 01:33:45 INFO - { 01:33:45 INFO - "project": "", 01:33:45 INFO - "product": "firefox", 01:33:45 INFO - "script_repo_revision": "production", 01:33:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:33:45 INFO - "repository": "", 01:33:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:33:45 INFO - "buildid": "20170326004006", 01:33:45 INFO - "stage_platform": "macosx64", 01:33:45 INFO - "basedir": "/builds/slave/test", 01:33:45 INFO - "nightly_build": "True", 01:33:45 INFO - "buildnumber": 31, 01:33:45 INFO - "slavename": "t-yosemite-r7-0381", 01:33:45 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:33:45 INFO - "platform": "yosemite_r7", 01:33:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:33:45 INFO - "branch": "mozilla-aurora", 01:33:45 INFO - "repo_path": "releases/mozilla-aurora", 01:33:45 INFO - "revision": "997b98cce1aebf76641e14c79ac250cdb147041c", 01:33:45 INFO - "pgo_build": "False", 01:33:45 INFO - "builduid": "d918ae29df214bf696bf8b8d7327c10a", 01:33:45 INFO - "slavebuilddir": "test" 01:33:45 INFO - } 01:33:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:33:45 INFO - Running post-action listener: _resource_record_post_action 01:33:45 INFO - [mozharness: 2017-03-26 08:33:45.960344Z] Finished read-buildbot-config step (success) 01:33:45 INFO - [mozharness: 2017-03-26 08:33:45.960492Z] Running download-and-extract step. 01:33:45 INFO - Running pre-action listener: _resource_record_pre_action 01:33:45 INFO - Running main action method: download_and_extract 01:33:45 INFO - mkdir: /builds/slave/test/build/tests 01:33:45 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')]} 01:33:45 INFO - trying https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:33:45 INFO - Downloading https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:33:47 INFO - Downloaded 1199 bytes. 01:33:47 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:33:47 INFO - Using the following test package requirements: 01:33:47 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:33:47 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:33:47 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:33:47 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'jsshell-mac.zip'], 01:33:47 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:33:47 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:33:47 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:33:47 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:33:47 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:33:47 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:33:47 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:33:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:33:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:33:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:33:49 INFO - Expected file size: 51787030 01:33:49 INFO - Obtained file size: 51787030 01:34:04 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:34:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:34:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:34:04 INFO - Fetch https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:34:06 INFO - Expected file size: 51787030 01:34:06 INFO - Obtained file size: 51787030 01:34:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:34:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:34:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:34:22 INFO - Expected file size: 14404438 01:34:22 INFO - Obtained file size: 14404438 01:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:23 INFO - trying https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:34:25 INFO - Downloaded 74735130 bytes. 01:34:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:34:25 INFO - mkdir: /builds/slave/test/properties 01:34:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:25 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:25 INFO - Contents: 01:34:25 INFO - build_url:https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:34:25 INFO - Running post-action listener: _resource_record_post_action 01:34:25 INFO - Running post-action listener: set_extra_try_arguments 01:34:25 INFO - [mozharness: 2017-03-26 08:34:25.943802Z] Finished download-and-extract step (success) 01:34:25 INFO - [mozharness: 2017-03-26 08:34:25.943966Z] Running populate-webroot step. 01:34:25 INFO - Running pre-action listener: _resource_record_pre_action 01:34:25 INFO - Running main action method: populate_webroot 01:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:25 INFO - '--tppagecycles', 01:34:25 INFO - '7'], 01:34:25 INFO - 'tests': ['tsvgm']}}, 01:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['damp', 'tps']}, 01:34:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'tests': ['damp', 'tps']}, 01:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['dromaeo_dom']}, 01:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['basic_compositor_video']}, 01:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tsvgx', 01:34:25 INFO - 'tsvgr_opacity', 01:34:25 INFO - 'tart', 01:34:25 INFO - 'tscrollx', 01:34:25 INFO - 'cart', 01:34:25 INFO - 'tsvg_static']}, 01:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:25 INFO - 'tsvgr_opacity', 01:34:25 INFO - 'tart', 01:34:25 INFO - 'tscrollx', 01:34:25 INFO - 'cart', 01:34:25 INFO - 'tsvg_static']}, 01:34:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tp5o']}, 01:34:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:34:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s', 01:34:25 INFO - '--xperf_path', 01:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:25 INFO - 'tests': ['tp5n']}, 01:34:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--xperf_path', 01:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:25 INFO - 'tests': ['tp5n']}}, 01:34:25 INFO - 'talos.zip': {'path': '', 01:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:25 INFO - Running post-action listener: _resource_record_post_action 01:34:25 INFO - [mozharness: 2017-03-26 08:34:25.962246Z] Finished populate-webroot step (success) 01:34:25 INFO - [mozharness: 2017-03-26 08:34:25.962364Z] Running create-virtualenv step. 01:34:25 INFO - Running pre-action listener: _resource_record_pre_action 01:34:25 INFO - Running main action method: create_virtualenv 01:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:25 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 01:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:26 INFO - Using real prefix '/tools/python27' 01:34:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:29 INFO - Installing pip.................done. 01:34:29 INFO - Return code: 0 01:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:34:29 INFO - Reading from file tmpfile_stdout 01:34:29 INFO - Output received: 01:34:29 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) 01:34:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34:29 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')]} 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:29 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')]} 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:29 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:29 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 01:34:29 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 01:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:29 INFO - 'HOME': '/Users/cltbld', 01:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:29 INFO - 'LOGNAME': 'cltbld', 01:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:29 INFO - 'MOZ_NO_REMOTE': '1', 01:34:29 INFO - 'NO_EM_RESTART': '1', 01:34:29 INFO - 'PAGER': '/bin/cat', 01:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:29 INFO - 'PWD': '/builds/slave/test', 01:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:29 INFO - 'SHELL': '/bin/bash', 01:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:29 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:29 INFO - 'USER': 'cltbld', 01:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:29 INFO - 'XPC_FLAGS': '0x0', 01:34:29 INFO - 'XPC_SERVICE_NAME': '0', 01:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:30 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 01:34:30 INFO - Cleaning up... 01:34:30 INFO - Return code: 0 01:34:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:30 INFO - 'HOME': '/Users/cltbld', 01:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:30 INFO - 'LOGNAME': 'cltbld', 01:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:30 INFO - 'MOZ_NO_REMOTE': '1', 01:34:30 INFO - 'NO_EM_RESTART': '1', 01:34:30 INFO - 'PAGER': '/bin/cat', 01:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:30 INFO - 'PWD': '/builds/slave/test', 01:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:30 INFO - 'SHELL': '/bin/bash', 01:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:30 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:30 INFO - 'USER': 'cltbld', 01:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:30 INFO - 'XPC_FLAGS': '0x0', 01:34:30 INFO - 'XPC_SERVICE_NAME': '0', 01:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:30 INFO - Downloading/unpacking psutil>=3.1.1 01:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:34 INFO - Installing collected packages: psutil 01:34:34 INFO - Running setup.py install for psutil 01:34:34 INFO - building 'psutil._psutil_osx' extension 01:34:34 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 INFO - building 'psutil._psutil_posix' extension 01:34:35 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 01:34:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:34:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:34:35 INFO - ^ 01:34:35 INFO - 1 warning generated. 01:34:35 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 01:34:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:35 INFO - Successfully installed psutil 01:34:35 INFO - Cleaning up... 01:34:35 INFO - Return code: 0 01:34:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:35 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:35 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 01:34:35 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 01:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:35 INFO - 'HOME': '/Users/cltbld', 01:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:35 INFO - 'LOGNAME': 'cltbld', 01:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:35 INFO - 'MOZ_NO_REMOTE': '1', 01:34:35 INFO - 'NO_EM_RESTART': '1', 01:34:35 INFO - 'PAGER': '/bin/cat', 01:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:35 INFO - 'PWD': '/builds/slave/test', 01:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:35 INFO - 'SHELL': '/bin/bash', 01:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:35 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:35 INFO - 'USER': 'cltbld', 01:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:35 INFO - 'XPC_FLAGS': '0x0', 01:34:35 INFO - 'XPC_SERVICE_NAME': '0', 01:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:34:38 INFO - Installing collected packages: mozsystemmonitor 01:34:38 INFO - Running setup.py install for mozsystemmonitor 01:34:38 INFO - Successfully installed mozsystemmonitor 01:34:38 INFO - Cleaning up... 01:34:38 INFO - Return code: 0 01:34:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34: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==2.5.1'] in /builds/slave/test/build 01:34: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==2.5.1 01:34:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:38 INFO - 'HOME': '/Users/cltbld', 01:34:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:38 INFO - 'LOGNAME': 'cltbld', 01:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:38 INFO - 'MOZ_NO_REMOTE': '1', 01:34:38 INFO - 'NO_EM_RESTART': '1', 01:34:38 INFO - 'PAGER': '/bin/cat', 01:34:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:38 INFO - 'PWD': '/builds/slave/test', 01:34:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:38 INFO - 'SHELL': '/bin/bash', 01:34:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:38 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:38 INFO - 'USER': 'cltbld', 01:34:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:38 INFO - 'XPC_FLAGS': '0x0', 01:34:38 INFO - 'XPC_SERVICE_NAME': '0', 01:34:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:39 INFO - Downloading/unpacking jsonschema==2.5.1 01:34:39 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 01:34:39 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 01:34:39 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 01:34:39 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 01:34:39 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 01:34:39 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 01:34:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:34:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:34:42 INFO - warning: no files found matching '*.txt' 01:34:42 INFO - no previously-included directories found matching 'build' 01:34:42 INFO - no previously-included directories found matching 'dist' 01:34:42 INFO - no previously-included directories found matching '.git*' 01:34:42 INFO - Installing collected packages: jsonschema, functools32 01:34:42 INFO - Running setup.py install for functools32 01:34:42 INFO - warning: no files found matching '*.txt' 01:34:42 INFO - no previously-included directories found matching 'build' 01:34:42 INFO - no previously-included directories found matching 'dist' 01:34:42 INFO - no previously-included directories found matching '.git*' 01:34:42 INFO - Successfully installed jsonschema functools32 01:34:42 INFO - Cleaning up... 01:34:42 INFO - Return code: 0 01:34:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:42 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:42 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 01:34:42 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 01:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:42 INFO - 'HOME': '/Users/cltbld', 01:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:42 INFO - 'LOGNAME': 'cltbld', 01:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:42 INFO - 'MOZ_NO_REMOTE': '1', 01:34:42 INFO - 'NO_EM_RESTART': '1', 01:34:42 INFO - 'PAGER': '/bin/cat', 01:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:42 INFO - 'PWD': '/builds/slave/test', 01:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:42 INFO - 'SHELL': '/bin/bash', 01:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:42 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:42 INFO - 'USER': 'cltbld', 01:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:42 INFO - 'XPC_FLAGS': '0x0', 01:34:42 INFO - 'XPC_SERVICE_NAME': '0', 01:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:34:42 INFO - Cleaning up... 01:34:42 INFO - Return code: 0 01:34:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:42 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:42 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 01:34:42 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 01:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:42 INFO - 'HOME': '/Users/cltbld', 01:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:42 INFO - 'LOGNAME': 'cltbld', 01:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:42 INFO - 'MOZ_NO_REMOTE': '1', 01:34:42 INFO - 'NO_EM_RESTART': '1', 01:34:42 INFO - 'PAGER': '/bin/cat', 01:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:42 INFO - 'PWD': '/builds/slave/test', 01:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:42 INFO - 'SHELL': '/bin/bash', 01:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:42 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:42 INFO - 'USER': 'cltbld', 01:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:42 INFO - 'XPC_FLAGS': '0x0', 01:34:42 INFO - 'XPC_SERVICE_NAME': '0', 01:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:43 INFO - Downloading/unpacking blobuploader==1.2.4 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:45 INFO - Downloading blobuploader-1.2.4.tar.gz 01:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:34:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:34:45 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 01:34:45 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 01:34:45 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 01:34:45 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 01:34:45 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 01:34:45 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 01:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:34:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:46 INFO - Downloading docopt-0.6.1.tar.gz 01:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:34:47 INFO - Installing collected packages: blobuploader, requests, docopt 01:34:47 INFO - Running setup.py install for blobuploader 01:34:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:34:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:34:47 INFO - Running setup.py install for requests 01:34:47 INFO - Running setup.py install for docopt 01:34:47 INFO - Successfully installed blobuploader requests docopt 01:34:47 INFO - Cleaning up... 01:34:47 INFO - Return code: 0 01:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:47 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:47 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 01:34:47 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 01:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:47 INFO - 'HOME': '/Users/cltbld', 01:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:47 INFO - 'LOGNAME': 'cltbld', 01:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:47 INFO - 'MOZ_NO_REMOTE': '1', 01:34:47 INFO - 'NO_EM_RESTART': '1', 01:34:47 INFO - 'PAGER': '/bin/cat', 01:34:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:47 INFO - 'PWD': '/builds/slave/test', 01:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:47 INFO - 'SHELL': '/bin/bash', 01:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:47 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:47 INFO - 'USER': 'cltbld', 01:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:47 INFO - 'XPC_FLAGS': '0x0', 01:34:47 INFO - 'XPC_SERVICE_NAME': '0', 01:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-Zf7tXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-wfGniq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-CzFLC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-9N7AUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-oIt9E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-PLBjQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-1HMxOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:48 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-DMRixQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-N2YnC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-eQC3bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-FjnToY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-m1YO6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-wjxEI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-WHMCfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-N9IMiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-XMGrec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:49 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-QvltfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:34:50 INFO - Running setup.py install for manifestparser 01:34:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Running setup.py install for mozcrash 01:34:50 INFO - Running setup.py install for mozdebug 01:34:50 INFO - Running setup.py install for mozdevice 01:34:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Running setup.py install for mozfile 01:34:50 INFO - Running setup.py install for mozhttpd 01:34:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Running setup.py install for mozinfo 01:34:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozInstall 01:34:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozleak 01:34:51 INFO - Running setup.py install for mozlog 01:34:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for moznetwork 01:34:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozprocess 01:34:51 INFO - Running setup.py install for mozprofile 01:34:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozrunner 01:34:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Running setup.py install for mozscreenshot 01:34:52 INFO - Running setup.py install for moztest 01:34:52 INFO - Running setup.py install for mozversion 01:34:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:34:52 INFO - Cleaning up... 01:34:52 INFO - Return code: 0 01:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:52 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:52 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 01:34:52 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 01:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:52 INFO - 'HOME': '/Users/cltbld', 01:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:52 INFO - 'LOGNAME': 'cltbld', 01:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:52 INFO - 'MOZ_NO_REMOTE': '1', 01:34:52 INFO - 'NO_EM_RESTART': '1', 01:34:52 INFO - 'PAGER': '/bin/cat', 01:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:52 INFO - 'PWD': '/builds/slave/test', 01:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:52 INFO - 'SHELL': '/bin/bash', 01:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:52 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:52 INFO - 'USER': 'cltbld', 01:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:52 INFO - 'XPC_FLAGS': '0x0', 01:34:52 INFO - 'XPC_SERVICE_NAME': '0', 01:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:52 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-4orIeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:52 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)) 01:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:52 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-wfBVdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-yRXiL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-5P6caZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-z9eX5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-DNpj9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-DSh88Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-AKQuHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-d88cag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-2CBrYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:53 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-X61jtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-8ZLPjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-6bY4U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-JOfO_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-gXhL1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-3_87Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:54 INFO - Running setup.py (path:/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/pip-ZkbeGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:57 INFO - Downloading blessings-1.6.tar.gz 01:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:34:57 INFO - Installing collected packages: blessings 01:34:57 INFO - Running setup.py install for blessings 01:34:57 INFO - Successfully installed blessings 01:34:57 INFO - Cleaning up... 01:34:57 INFO - Return code: 0 01:34:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:57 INFO - Reading from file tmpfile_stdout 01:34:57 INFO - Current package versions: 01:34:57 INFO - blessings == 1.6 01:34:57 INFO - blobuploader == 1.2.4 01:34:57 INFO - docopt == 0.6.1 01:34:57 INFO - functools32 == 3.2.3-2 01:34:57 INFO - jsonschema == 2.5.1 01:34:57 INFO - manifestparser == 1.1 01:34:57 INFO - mozInstall == 1.12 01:34:57 INFO - mozcrash == 1.0 01:34:57 INFO - mozdebug == 0.1 01:34:57 INFO - mozdevice == 0.49 01:34:57 INFO - mozfile == 1.2 01:34:57 INFO - mozhttpd == 0.7 01:34:57 INFO - mozinfo == 0.9 01:34:57 INFO - mozleak == 0.1 01:34:57 INFO - mozlog == 3.4 01:34:57 INFO - moznetwork == 0.27 01:34:57 INFO - mozprocess == 0.25 01:34:57 INFO - mozprofile == 0.28 01:34:57 INFO - mozrunner == 6.13 01:34:57 INFO - mozscreenshot == 0.1 01:34:57 INFO - mozsystemmonitor == 0.3 01:34:57 INFO - moztest == 0.8 01:34:57 INFO - mozversion == 1.4 01:34:57 INFO - psutil == 3.1.1 01:34:57 INFO - requests == 1.2.3 01:34:57 INFO - wsgiref == 0.1.2 01:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:57 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')]} 01:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:57 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')]} 01:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:57 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:57 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 01:34:57 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 01:34:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:57 INFO - 'HOME': '/Users/cltbld', 01:34:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:57 INFO - 'LOGNAME': 'cltbld', 01:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:57 INFO - 'MOZ_NO_REMOTE': '1', 01:34:57 INFO - 'NO_EM_RESTART': '1', 01:34:57 INFO - 'PAGER': '/bin/cat', 01:34:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:57 INFO - 'PWD': '/builds/slave/test', 01:34:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:57 INFO - 'SHELL': '/bin/bash', 01:34:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:57 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:57 INFO - 'USER': 'cltbld', 01:34:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:57 INFO - 'XPC_FLAGS': '0x0', 01:34:57 INFO - 'XPC_SERVICE_NAME': '0', 01:34:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 INFO - Cleaning up... 01:34:58 INFO - Return code: 0 01:34:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 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 0x108f93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecb3c895e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, '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.Ir444pvT8P/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.kghmRfQcjA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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 01:34:58 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 01:34:58 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 01:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:58 INFO - 'HOME': '/Users/cltbld', 01:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:58 INFO - 'LOGNAME': 'cltbld', 01:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:58 INFO - 'MOZ_NO_REMOTE': '1', 01:34:58 INFO - 'NO_EM_RESTART': '1', 01:34:58 INFO - 'PAGER': '/bin/cat', 01:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:58 INFO - 'PWD': '/builds/slave/test', 01:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:58 INFO - 'SHELL': '/bin/bash', 01:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:34:58 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:58 INFO - 'USER': 'cltbld', 01:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:58 INFO - 'XPC_FLAGS': '0x0', 01:34:58 INFO - 'XPC_SERVICE_NAME': '0', 01:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:34:58 INFO - Cleaning up... 01:34:58 INFO - Return code: 0 01:34:58 INFO - Running post-action listener: _resource_record_post_action 01:34:58 INFO - Running post-action listener: _start_resource_monitoring 01:34:58 INFO - Starting resource monitoring. 01:34:58 INFO - [mozharness: 2017-03-26 08:34:58.547331Z] Finished create-virtualenv step (success) 01:34:58 INFO - [mozharness: 2017-03-26 08:34:58.548310Z] Running install step. 01:34:58 INFO - Running pre-action listener: _resource_record_pre_action 01:34:58 INFO - Running main action method: install 01:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:58 INFO - Reading from file tmpfile_stdout 01:34:58 INFO - Detecting whether we're running mozinstall >=1.0... 01:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:34:58 INFO - Reading from file tmpfile_stdout 01:34:58 INFO - Output received: 01:34:58 INFO - Usage: mozinstall [options] installer 01:34:58 INFO - Options: 01:34:58 INFO - -h, --help show this help message and exit 01:34:58 INFO - -d DEST, --destination=DEST 01:34:58 INFO - Directory to install application into. [default: 01:34:58 INFO - "/builds/slave/test"] 01:34:58 INFO - --app=APP Application being installed. [default: firefox] 01:34:58 INFO - mkdir: /builds/slave/test/build/application 01:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:35:19 INFO - Reading from file tmpfile_stdout 01:35:19 INFO - Output received: 01:35:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:35:19 INFO - Running post-action listener: _resource_record_post_action 01:35:19 INFO - [mozharness: 2017-03-26 08:35:19.258202Z] Finished install step (success) 01:35:19 INFO - [mozharness: 2017-03-26 08:35:19.258342Z] Running run-tests step. 01:35:19 INFO - Running pre-action listener: _resource_record_pre_action 01:35:19 INFO - Running main action method: run_tests 01:35:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:35:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:35:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:35:19 INFO - 2017-03-26 01:35:19.272 screenresolution[1633:9331] starting screenresolution argv=screenresolution get 01:35:19 INFO - 2017-03-26 01:35:19.275 screenresolution[1633:9331] Display 0: 1600x1200x32@60 01:35:19 INFO - 2017-03-26 01:35:19.281 screenresolution[1634:9334] starting screenresolution argv=screenresolution list 01:35:19 INFO - Available Modes on Display 0 01:35:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:35:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:35:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:35:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:35:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:35:19 INFO - Intel Iris: 01:35:19 INFO - Chipset Model: Intel Iris 01:35:19 INFO - Type: GPU 01:35:19 INFO - Bus: Built-In 01:35:19 INFO - VRAM (Dynamic, Max): 1536 MB 01:35:19 INFO - Vendor: Intel (0x8086) 01:35:19 INFO - Device ID: 0x0a2e 01:35:19 INFO - Revision ID: 0x0009 01:35:19 INFO - Displays: 01:35:19 INFO - Display: 01:35:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:35:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:35:19 INFO - Display Serial Number: 1600x1200 60 01:35:19 INFO - Main Display: Yes 01:35:19 INFO - Mirror: Off 01:35:19 INFO - Online: Yes 01:35:19 INFO - Rotation: Supported 01:35:19 INFO - Return code: 0 01:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:19 INFO - Python 2.7.3 01:35:19 INFO - Return code: 0 01:35:19 INFO - grabbing minidump binary from tooltool 01:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:35:19 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 0x108d71d30>, '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 0x108c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d66be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:19 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 01:35:19 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 01:35:19 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 01:35:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:19 INFO - Return code: 0 01:35:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:35:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:19 INFO - ENV: RUST_BACKTRACE is now 1 01:35:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:35:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 01:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0381 --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 01:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ir444pvT8P/Render', 01:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:19 INFO - 'HOME': '/Users/cltbld', 01:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:19 INFO - 'LOGNAME': 'cltbld', 01:35:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:19 INFO - 'MOZ_NO_REMOTE': '1', 01:35:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:19 INFO - 'NO_EM_RESTART': '1', 01:35:19 INFO - 'PAGER': '/bin/cat', 01:35:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:19 INFO - 'PWD': '/builds/slave/test', 01:35:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:19 INFO - 'RUST_BACKTRACE': '1', 01:35:19 INFO - 'SHELL': '/bin/bash', 01:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kghmRfQcjA/Listeners', 01:35:19 INFO - 'TMPDIR': '/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/', 01:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:19 INFO - 'USER': 'cltbld', 01:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:19 INFO - 'XPC_FLAGS': '0x0', 01:35:19 INFO - 'XPC_SERVICE_NAME': '0', 01:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0381', '--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 01:35:19 INFO - mozversion application_buildid: 20170326004006 01:35:19 INFO - mozversion application_changeset: 997b98cce1aebf76641e14c79ac250cdb147041c 01:35:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:35:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:19 INFO - mozversion application_name: Firefox 01:35:19 INFO - mozversion application_remotingname: firefox-dev 01:35:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:19 INFO - mozversion application_vendor: Mozilla 01:35:19 INFO - mozversion application_version: 54.0a2 01:35:19 INFO - mozversion platform_buildid: 20170326004006 01:35:19 INFO - mozversion platform_changeset: 997b98cce1aebf76641e14c79ac250cdb147041c 01:35:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:19 INFO - mozversion platform_version: 54.0a2 01:35:19 INFO - using testdate: 1490517319 01:35:19 INFO - actual date: 1490517319 01:35:19 INFO - starting webserver on 'localhost:49242' 01:35:19 INFO - SUITE-START | Running 2 tests 01:35:19 INFO - TEST-START | dromaeo_css 01:35:19 INFO - operating with platform_type : mac_ 01:35:19 INFO - Initialising browser for dromaeo_css test... 01:35:19 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpGC8OWI/profile http://localhost:49242/getInfo.html) 01:35:22 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 01:35:22 INFO - PROCESS | 1644 | colorDepth:24 01:35:22 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 01:35:22 INFO - PROCESS | 1644 | __metrics 01:35:22 INFO - PROCESS | 1644 | 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" 01:35:22 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:35:23 INFO - TEST-INFO | 1644: exit 0 01:35:23 INFO - Browser initialized. 01:35:23 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:23 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpGC8OWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:35 INFO - PROCESS | 1648 | RSS: Main: 214687744 01:35:35 INFO - PROCESS | 1648 | 01:38:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 01:38:42 INFO - PROCESS | 1648 | RSS: Main: 439410688 01:38:42 INFO - PROCESS | 1648 | 01:40:25 INFO - PROCESS | 1648 | ************************* 01:40:25 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 01:40:25 INFO - PROCESS | 1648 | 01:40:25 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:25 INFO - PROCESS | 1648 | Full stack: 01:40:25 INFO - PROCESS | 1648 | ************************* 01:41:45 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 01:41:45 INFO - PROCESS | 1648 | RSS: Main: 351490048 01:41:45 INFO - PROCESS | 1648 | 01:44:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 01:44:48 INFO - PROCESS | 1648 | RSS: Main: 344592384 01:44:48 INFO - PROCESS | 1648 | 01:47:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 01:47:51 INFO - PROCESS | 1648 | RSS: Main: 346374144 01:47:51 INFO - PROCESS | 1648 | 01:50:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 01:50:56 INFO - PROCESS | 1648 | RSS: Main: 318369792 01:50:56 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 01:53:59 INFO - PROCESS | 1648 | RSS: Main: 370073600 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | __start_tp_report 01:53:59 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 01:53:59 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 01:53:59 INFO - PROCESS | 1648 | |i|pagename|runs| 01:53:59 INFO - PROCESS | 1648 | |0;dojo.html;2932.9999999999995;3407.454807230842;3417.453207486802;3434.605020422649;3462.1344663834043;4644.489106198315;5965.940340596593;5990.520758339333;6022.789202377918;6065.69671516424;5995.6102853314505;6050.909236361458;6057.36397678243;6074.848128796772;6081.847953801157;5380.838574842751;5404.4595540446035;5438.401775804658;5509.311336082989;5534;5296.576273898098;5307.973460132714;5518.475744804237;5530.557555395559;5533.335999680044;5349.652272602269;5406.945930540704;5416.241726158341;5424.891502169974;5440.972795136019;5415.079436495786;5415.83752487426;5426.67439953604;5429;5431.131019036935;5234.6335756497065;5357.008953343644;5358.276632654581;5367.382750983647;5383.246345511592;6010.789622363196;6016.8495787605225;6020.8494787630225;6023.367546407608;6030.427109424598;6305.8108256752375;6342.904856427157;6343.302236753953;6351.491880649537;6364.045393191012;6302.054691796221;6331.683415829236;6387;6456.580322279036;6501;4760.809567617292;6148.754049838001;6153.323134455206;6158.907616385713;6165.907511387288;6321.810345689637;6552.541322107454;6596.142501474777;6615.239247486505;6625.469962402996;5266.34170728659;6258.3741625837965;6275.309715931244;6310.936890631035;6321.051842223703;6472.967635161794;6495.8700825983215;6496.935030649633;6508.739650414025;6511.544191906616;6360.904586431115;6374.171357723466;6390.201224846895;6392.648404337806;6393.776217832354;6115.553609370865;6339.841503962438;6369.14016607752;6387.552871298964;6392.616443013434;4318.805653745589;5081.72050537224;5135.948640513547;5176;5185.092608793521;4587.105514424722;4598.1033698429155;4629.814807407666;4642.187617166982;4665.346851440801;6061.818145455643;6083.062376573406;6089.360617135137;6107.725152368154;6111.174991376108;6291.339409362043;6331.335209802996;6351.460125889259;6451.774187903401;6512.641804700692;5880.235569375954;5884.794032208938;5895.55783316253;5904.321003084614;5913.526917846562;5602.719864006784;5607.243022192033;5608.775648974077;5608.9439105609235;5627.324721033502;6416.454601358843;6499.38255865692;6511.999999999905;6569.737210511526;6611.173603299588;6499.155109835691;6500.577462464925;6505.154329937267;6512.73949042033;6534.869302614016;6697.296783837627;6697.497687673346;6711.697973591297;6717.764878229238;6723.932760672331;6231.3145553988115;6291.087792270004;6302.054691796267;6421;6437.25971513282;6186.690665466798;6299.527535434769;6326.6836658165985;6329.873402531832;6339.207599050119;6251.187345645037;6275.592086514362;6335.968320158369;6336.239651241881;6356.650384228727;6310.463610592968;6326.6520341381665;6327.3356297589935;6329.651869147241;6342.365763423621;6286.40279173496;6290.339514350927;6304.873902522016;6312.14786003902;6322.399372059647;6090.543209259235;6093.634381937098;6121.666376154749;6242.032484964838;6252.812415627538;6308.053791931247;6313.273973492924;6317.9052314214405;6321.1782468278825;6332.335104814112 01:53:59 INFO - PROCESS | 1648 | |1;ext.html;772.7874834420535;795.5942469340637;856.7772379181415;867.496851825941;871.6949067826262;38023.42964855526;38514;40317;40335.19329613406;40358.39462408066;39124.60875391245;39299.41050884239;39373.803130984306;39459.40810887839;39470.605293947054;7166.60583667898;9021.323400744937;9190.264778817678;9190.540472976358;9214.585343659517;6198.44214020738;10751.462426878665;11038.503267352988;11143.888561114367;11160.609378671748;10948.45257737114;11006.174536909724;11020.724481887977;11049.613263535777;11052.723681907977;10926.890731092666;10951.288166269167;10953.561857525729;10974.024675558396;10978;6204.317525072239;7347.7795666130105;7382.040334756501;7383.187849336568;7395.149557800814;36929.630703692885;37553;38824.41763373552;39115.6309529168;39144.80427597872;3744.719146064056;3783.39465685489;3787.734858559902;3799.772013679188;3840.0399900024995;26187.345316367053;26322.6051609226;26705.33236669099;27359;28088.578671319945;2984.567237750514;3000.5499175123905;3058.0672894767085;3227.644959054502;3233.175540237248;367543;370427;370763;371322;372428.13785931165;42957.35563966543;43167.78416107899;43208;43350;43372.132557348676;43333.91665208332;43466.56533434689;43474;43481;43488;12932.030097742707;13231.20612763218;13238.73522529544;13252;13269;9652.565634546463;11739.47172377245;11755.471003804849;11755.529778808923;11755.823662645067;10702.625408110678;11173;11334.036606888341;11464.426778661034;11464.713382165346;4666.486686464486;5447.521248224075;5562.638428502134;5574.303212098488;5609.915851262234;1048.2598885849454;1066.9970227985668;1086.6196831109048;1131.5247596009697;1136.5851464215666;21809.563808724055;24327.513449730905;25170.74829251684;25370.365740856625;25435.872820635777;984.9461076648062;1179.2334982261427;1179.351356753782;1191.398343836357;1219.670688914006;12841.678958026125;12980.912763967111;12999.480020799252;13022.609321720363;13138.211707297593;463691;464167;466368;469787;479518;55273;55837.441625583226;55871.441285586625;55936.440635593935;55963.44036559664;1198.8920997110301;1253.2981530343036;1399.846016938136;1462.1300326305832;1462.648964248594;23312.76687233106;27105.051323203592;28697.995570154944;28754.281142971595;29465.55801662934;51767.705807355116;51990.74004629953;52058;52085.7395713019;52098.21852672137;461520.6923965359;465952;466104.6694766504;466382;468449;30742.846285768428;31100;31183.064508064796;31319.84340078285;31393.68606313999;43206.50687826008;44546.77726611346;44632.33051504295;44760.328595071755;44791;28474.57288140638;29773.255668608457;30148.24629384283;30682;30693.53959690651;28063;30089.849550752107;30404;30483;30724.92462763882;35047;35678.4648230282;36408.27183456263;36458.63541364658;36619.08452288714;24374.634380484662;29868;30097;30197.09408717742;30752.923647672225;21921.780782191974;22084.116635334405;23046.884765576066;23458.296251112493;23554.88222558876 01:53:59 INFO - PROCESS | 1648 | |2;jquery.html;362.4147002590815;381.7404165167685;389.60649743758796;408.79968815280523;424.0501277139208;13305.534306299269;15755.68488630228;20819.959002049894;22508.88745556274;22880.199193028246;19291.710624340645;19663.803361966377;20027.89986050068;20158;22129;6479.805605831821;6821.113255276832;6825.419839313639;6829.521933464659;6830.590164590116;7503.849923001564;7871.5277083374895;8001.1198768135455;8008.55952922589;8021.799455013613;6625.337466253361;7711.4216433767415;7988.920110798905;7994.360451163922;8000.559969201691;7582.431317651198;8003.839923201504;8007.959960200191;8065.475744076616;8082.353411727047;7570;7886.763397098096;7904.1700621435075;7935.523868567847;7949;29779.851100744574;30189.849050754605;30261.394772104653;30405.695943040508;30601.693983060108;2865.9856700716573;2915.9125226243245;3060.709232622897;3080.3377273886;3098.395812816502;16608.25262863174;17325;17850.91074544619;18465.261389544536;18557.35049273269;2013.416109328293;2032.5934813037452;2043.1010355443557;2047.2732180076157;2114.397396741921;131646;144766.2761686185;145884;156895;162650.1867490655;17043.659126817394;23009.53980920372;23647;23711.968965275944;23849.642255366183;42655;42779.786101069294;43266.783666081465;43791.56208437875;43849.78075109604;11395.487203075882;11579.478923448465;11607.071434285237;11616.012638925617;11794.705132371759;9063.864042039375;9091.31815113869;9126.406783559047;9154.130357616015;9272.72181834546;9236.307276954256;11255;11355.602553910574;11388;11525.76948461026;3494.3884820156372;4266.786660666954;4298.720583162084;4311.137772445523;4315.870523884289;926.8331700293877;940.6190492850407;969.9951500242454;976.2970661123979;980.3823591137538;15388;19339.51651208731;20566.794332056787;20581.07385167671;20650;846.9280111190618;947.1475671895349;980.4264505264357;991.2119864707574;998.2912132385942;9993.900060999296;10693.78612427747;10773.515191816387;10773.83839242412;10777.353358798497;726448;727197;738970;740117;754713;125385;134851.3257433726;138703.6129638711;142837.57230924634;145011;1104.1773878460438;1108.4956344863228;1164.8776878427811;1165.5687395663658;1166.2361153444508;17629.118544072488;17690.292388304322;18113.909430452764;18151.546211344295;18408.539786505444;61195;61262;61592;61684.69157654183;62502.37497625148;83700.58149709456;84611;86044.13955860361;88008;88912.5554372224;10796.892031079902;11022.559097636326;11283.887161128283;11286.66140015801;11405.087592992706;11046.447677616248;11170.832437513282;12087.456064476944;12349.69125771827;12407.131500795218;10441.477926103817;10449.791004180026;10593;10757.193210509087;10772.946135269274;9858.704238872846;10000.44997525114;10034.949825250827;10102.646407375707;10174.287799853939;8691.304695624462;10667.679969600924;11314.264572802742;11416.429178540873;11768.823467648162;11280.717982050515;11553.94223028913;11931.4034298283;12017.819732703842;12019.519219231133;10917.508712108132;11050.447477625925;11091;11187.496562654864;11370 01:53:59 INFO - PROCESS | 1648 | |3;mootools.html;1290.8321918150646;1551.9146446945413;1575.3855996161499;1594.792676951996;1598.7841641378413;10598.894011059887;11178.944105279463;11205.271657342268;11242.66272011839;11253.381064041474;10719.303245289051;10990.340579565212;11019.944900275488;11190.944045279783;11216.551337946472;2325.697659304288;2352.188494969233;2358.2099996501192;2358.2689366296504;2363.621820508719;2268.852524585897;2344.788968992799;2347.424880904181;2349.659299401594;2351.1065794997876;2214.9889250553724;2260.7513173550897;2266.9206577769783;2315.8610483370967;2332.3003099070297;2252.650839119939;2319.489712263299;2321.2339927823778;2324.5583339165587;2324.639680849471;2310.330004298751;2311.5723591135693;2315.3169814904645;2320.002398968443;2327.394877331889;11160.832587511193;11264.774704505864;11266.830997535044;11274.492647830868;11339.603113891057;5349.7057661828585;5521.723913804293;5521.723913804334;5526.668399896019;5532.336119665666;3180.8250546219947;3252;3411.829408529564;3479.530263414432;3487.5814902211896;1143.034136154956;1155.9768804623861;1165.9883401165964;1173.6303064534645;1193.516625766566;13769.518066867711;14167.787483187658;14355.138691678429;15626.14056226907;15641.452549160838;3720.6651401374006;3761.7962252079074;4111.09555897702;4249.32010878258;4445.333200019958;11872.931436170613;11895.345755983504;11909.22590031645;11916.285022898654;11919.046476281877;5419.512243898068;5446.700431476307;5450.618456707993;5453.945460545344;5475.534579560703;4773.307870358779;5018.949810501921;5073.264376665436;5075.264086707407;5102.846914592568;3550.5384300041346;3662.3957047087465;3683.889483315505;3724.944125838115;3759.342115129841;910.7313342563959;913.8126684029758;922.8800255966815;925.3892430995511;927.8608208768603;787.169536139367;807.8182408957938;808.4785313472777;822.7284995951321;843.3169133002287;6332.145160403286;6489.318621544764;6594.175728033996;6606.405423511907;6618.63597502142;954.8233576788316;1044.5090807320548;1044.6761503933806;1048.0410424461531;1077.956881724738;4106.2198182345255;4111.958880411217;4146.523149837747;4232.703710740218;4247.97876010618;10758.623448179276;13425.328733563478;13585.932070339584;13794.103383280055;13927.860721392859;13101.606951791462;13793.586192414243;13794.37925293344;13796.965227607969;13823.654408639864;9644.710658680251;10005.49972501372;10038.74903127413;10052.849207261897;10057.547410366551;6769.627670477974;6774.085498457645;6874.484413668894;6955.965220173866;7040.119985001875;11603.709907252387;12268.877311226774;12298.016158707103;12455.343536242224;12619.369031548202;10608.89391106079;11221.158413119212;12603.369831508571;12850.036247281305;12856.485740570273;9122.498262595622;9309.348345615741;9354.111359420844;9405.85891211646;9438.575264112995;10193.980601939747;10282.537285822007;10319.380837149794;10401.895981040092;10448;8837.337199709918;8857.247133993682;8915.598798053974;8917.866232006654;8953.597088130919;8517.531535765593;8568.657253709782;8654.177853103945;8661.740147795575;8694.869576956224;7860.489068210548;7875.173106823701;7888.17174196724;7947.8807817881625;7983.5209887406945;5048.974755126201;5413.891722165614;5732.856678583069;5789.739461724148;6031.336552979081;5010.49895010496;5106.438291787975;5793.15999180125;5974.342822289632;6001 01:53:59 INFO - PROCESS | 1648 | |4;prototype.html;295.9067893613512;359.1326945426794;377.32270574319097;378.6573151298076;383.2794346628338;4179.644730197933;4781.900162962512;4984.850454486371;5026.447090820011;5059.772310246043;4587.357769912215;4686.71879687219;4696.248600223965;4905.41135063792;4992.475790042039;3365.5793025871767;3533.2617221653295;4092.3452247640457;4164.583541645827;4182.285263042153;3674.8346324415334;4178.767263657213;4179.91640167198;4203.26442872496;4220.324748040314;3931;4066;4103.158852435258;4147.6474499667565;4157.875263742093;3331.4669652855546;3488.6336934621754;4061.208064427423;4074.8166332515107;4164.7709375984305;3359.445691460906;3528.947065794015;3813.0657988792923;3817.522809648794;3851.4030325299345;3937.6415136777764;4267.8079486423185;4633.374494443241;4852.2289364382095;4894.021195760826;4673.948361618643;4792.48394592838;4820.590249828769;4837.516248375169;4861.440934292531;4341.218580655481;4660.184467718136;5296.417394086686;5335.67985920846;5408.161734931092;3960.8019599019935;4267.103908179286;4275.358696195564;4282.451941095043;4313.374560688682;4651.279051746985;5159.896802063938;5416.350037995466;5420.810271640474;5713.028785106542;3911.2568611963634;4223.809928553223;4336.132773445323;4360.193364227628;4370.628496577763;3990.620891015349;4267.997020700133;4306.181825453154;4467.419235499365;4569.543045695404;4533;4604.58558729716;4627.079761898842;4757.691634800458;4873.829415970495;4846.32329801743;5247.737613119405;5300.16441203954;5324.893502129936;5326.467353264643;1259.7354555543254;1358.1443690475135;1386.0228538880065;1471.837248573615;1495.8055452791068;1010.6709676775017;1042.5985995391677;1066.568039943824;1133.7165708572857;1160.5763896178003;4424.734515929054;4767.284907263869;4916;4963.6277279204205;4980.7509624518625;5135.7388058583065;5396.4333744957;5460.180972854104;5469.808556700496;5481.260029895913;3982.661473774762;4902.8774280643265;4919.311296418504;4949;5184.870378240575;2568.961465578018;2772.875220615077;2798.272449163232;2884.5961565380862;2887.63904511936;4916.2625606158645;5525.668459892419;5625.862172374472;5650.689212093293;5726.455986681259;4515.593596576258;5028.094942910238;5563.582731295169;5566.888662226733;5652.576056795757;5131.867418434935;5235.528802407802;5730.570207234474;5746.454086861741;5749.1663708762;4603.895065184399;4768.809247630056;4807.567318941312;5531.321671088842;5543.223948647112;4470.396496472935;5187.481251874782;5424.267723857387;5473.397926228032;5528.806491772769;4759.881002974953;5256.684598924076;5264.394594621667;5553.889521981621;5560.555155587463;3899.8440062397185;4113;4448.243798554318;4451.775761665568;4484.349769283501;4547.749873756843;5128.871778205575;5138.640295179451;5337.866553336197;5526.668399895858;4060.5127384714024;4871.63462740303;4945.060438516671;5059.519345662156;5135.270040930359;4315.676324275629;4617.46899106607;5240.71176085319;5298.523132918056;5304.7082410466255;4251.744895306291;4878.90242195147;5170.560502357342;5256.290400795843;5309.893802124013;4495.617872480745;5270.393904701008;5292.6127278541;5318.574514038945;5388.164834450667;4419.845305414295;5195.298634684269;5198.8960220796125;5199.63602547818;5202.358349155531 01:53:59 INFO - PROCESS | 1648 | |5;yui.html;714.8284411741183;717.6626985316901;738.0995185873232;776.8329809091044;839.0937787189833;14780.852191478096;15561.766573501407;15564.455244066474;15569.143697096655;15584.220788960549;14032.92983535081;14046.297685115755;14053.929730351334;14083.366248518816;14733.852661473382;928.6981730937456;940.2337095267369;958.2190514730507;960.7934294126761;977.8044391121769;964.2382517810921;966.0677446264353;966.2801213096218;967.9854802177973;968.8788901387327;1007.9496025198747;1009.7980403919208;1009.9495025248744;1010.7624708193568;1014.8071866345408;1003.6186249225284;1005.964791232307;1006.3458751811309;1007.9143272821746;1009.1976878381631;746.2910235276455;749.1459735901077;749.1497150733902;749.7226026370223;751.4176513202258;15564.61088472786;15747.685046299124;15765.132917689523;16038.278277477542;16302.836971630251;13277.203367797963;13894.305284735823;13977.510787122503;14067.366968486444;14139.787903181461;11559.422028898605;11795.967538036773;11819.940900295529;11832.704182395422;12012.879871201263;3563.251717139404;3618.203995121069;3710.461983012448;3748.456473811282;3834.0223243073115;99447.50276248645;104325.99999999924;104394;104699.42950855743;108272;10590.894091059145;10670.146388288918;10711;10762.515686794113;10772.946135269274;21889.890550547465;21987.23044693428;21990.340289791333;22348;22433.87830608463;7294;7357.0803649543805;7695.538267703956;7724.3434308083315;7821.530708157415;4185.58144185579;4206.453161089039;4265.701400901907;4313.633341165973;4449.532799056117;3503.737219708532;3559.1635965548076;3600.855965761393;3605.5853576838476;3608.530890984208;617.8733359661259;655.5476721062452;656.917885264342;657.9967100164469;658.4304576541257;643.4016364780705;675.4495086504484;680.2585182151479;688.3942130924754;700.3556727810427;8854.955725221333;9478.478683672463;10205.795884082278;10297.279190456746;10543.209259305582;645.2289514030688;680.4216416046321;686.5503095472474;693.3690341788948;713.0730050933765;4610.815567377334;4941.234108713155;4948.356713627206;4948.678335908155;4956.157453232959;98657;104083.8774836756;105228;106760;110247;83591.74612380819;88986.32216568296;91641;92653;92663.53668231616;81463.5926820374;81468.18531814606;82186.17813821786;82978.17021829705;84830.303393933;9481.845612773148;9601.567929443052;9602.747612713543;9704.563294651616;9865.605375784888;50490.747546262035;50927.19900405365;52178.73910630422;53321.93356132933;53372.4662753383;67010.6649466769;69807.6509617469;70287.64856175687;75446.8682969745;77587.22412776026;11143.33140011602;12082.45628946717;14048.719025619226;14206.147631142165;14206.857931420553;14774.77837832412;14777.610524067335;15331.386744530093;15347.309371078105;15381.230938452809;13484.86515134836;13735.313234338044;14278.500252491112;14287.57137285883;14382.712345752818;13747.862521374658;13955.441782328999;14260.00179987391;14283.571492855232;14598.635034124232;13523.932380338036;13826.930865345608;14020.509282175075;14287.357068931715;14492;8435.536045517556;9043.909560904307;9665.468399237829;9997.55011024491;9997.75005624836;11377.43112844371;11390.229850805346;11602.303861767983;11740.70648233801;11805.468753906267 01:53:59 INFO - PROCESS | 1648 | __end_tp_report 01:53:59 INFO - PROCESS | 1648 | __start_cc_report 01:53:59 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2510 01:53:59 INFO - PROCESS | 1648 | __end_cc_report 01:53:59 INFO - PROCESS | 1648 | __startTimestamp1490518439906__endTimestamp 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | ------- Summary: start ------- 01:53:59 INFO - PROCESS | 1648 | Number of tests: 6 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5940.35 Median:6242.03 stddev:694.57 (11.1%) stddev-sans-first:655.41 01:53:59 INFO - PROCESS | 1648 | Values: 2933.0 3407.5 3417.5 3434.6 3462.1 4644.5 5965.9 5990.5 6022.8 6065.7 5995.6 6050.9 6057.4 6074.8 6081.8 5380.8 5404.5 5438.4 5509.3 5534.0 5296.6 5308.0 5518.5 5530.6 5533.3 5349.7 5406.9 5416.2 5424.9 5441.0 5415.1 5415.8 5426.7 5429.0 5431.1 5234.6 5357.0 5358.3 5367.4 5383.2 6010.8 6016.8 6020.8 6023.4 6030.4 6305.8 6342.9 6343.3 6351.5 6364.0 6302.1 6331.7 6387.0 6456.6 6501.0 4760.8 6148.8 6153.3 6158.9 6165.9 6321.8 6552.5 6596.1 6615.2 6625.5 5266.3 6258.4 6275.3 6310.9 6321.1 6473.0 6495.9 6496.9 6508.7 6511.5 6360.9 6374.2 6390.2 6392.6 6393.8 6115.6 6339.8 6369.1 6387.6 6392.6 4318.8 5081.7 5135.9 5176.0 5185.1 4587.1 4598.1 4629.8 4642.2 4665.3 6061.8 6083.1 6089.4 6107.7 6111.2 6291.3 6331.3 6351.5 6451.8 6512.6 5880.2 5884.8 5895.6 5904.3 5913.5 5602.7 5607.2 5608.8 5608.9 5627.3 6416.5 6499.4 6512.0 6569.7 6611.2 6499.2 6500.6 6505.2 6512.7 6534.9 6697.3 6697.5 6711.7 6717.8 6723.9 6231.3 6291.1 6302.1 6421.0 6437.3 6186.7 6299.5 6326.7 6329.9 6339.2 6251.2 6275.6 6336.0 6336.2 6356.7 6310.5 6326.7 6327.3 6329.7 6342.4 6286.4 6290.3 6304.9 6312.1 6322.4 6090.5 6093.6 6121.7 6242.0 6252.8 6308.1 6313.3 6317.9 6321.2 6332.3 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:56445.44 Median:3230.41 stddev:116264.70 (3599.1%) stddev-sans-first:116515.71 01:53:59 INFO - PROCESS | 1648 | Values: 772.8 795.6 856.8 867.5 871.7 38023.4 38514.0 40317.0 40335.2 40358.4 39124.6 39299.4 39373.8 39459.4 39470.6 7166.6 9021.3 9190.3 9190.5 9214.6 6198.4 10751.5 11038.5 11143.9 11160.6 10948.5 11006.2 11020.7 11049.6 11052.7 10926.9 10951.3 10953.6 10974.0 10978.0 6204.3 7347.8 7382.0 7383.2 7395.1 36929.6 37553.0 38824.4 39115.6 39144.8 3744.7 3783.4 3787.7 3799.8 3840.0 26187.3 26322.6 26705.3 27359.0 28088.6 2984.6 3000.5 3058.1 3227.6 3233.2 367543.0 370427.0 370763.0 371322.0 372428.1 42957.4 43167.8 43208.0 43350.0 43372.1 43333.9 43466.6 43474.0 43481.0 43488.0 12932.0 13231.2 13238.7 13252.0 13269.0 9652.6 11739.5 11755.5 11755.5 11755.8 10702.6 11173.0 11334.0 11464.4 11464.7 4666.5 5447.5 5562.6 5574.3 5609.9 1048.3 1067.0 1086.6 1131.5 1136.6 21809.6 24327.5 25170.7 25370.4 25435.9 984.9 1179.2 1179.4 1191.4 1219.7 12841.7 12980.9 12999.5 13022.6 13138.2 463691.0 464167.0 466368.0 469787.0 479518.0 55273.0 55837.4 55871.4 55936.4 55963.4 1198.9 1253.3 1399.8 1462.1 1462.6 23312.8 27105.1 28698.0 28754.3 29465.6 51767.7 51990.7 52058.0 52085.7 52098.2 461520.7 465952.0 466104.7 466382.0 468449.0 30742.8 31100.0 31183.1 31319.8 31393.7 43206.5 44546.8 44632.3 44760.3 44791.0 28474.6 29773.3 30148.2 30682.0 30693.5 28063.0 30089.8 30404.0 30483.0 30724.9 35047.0 35678.5 36408.3 36458.6 36619.1 24374.6 29868.0 30097.0 30197.1 30752.9 21921.8 22084.1 23046.9 23458.3 23554.9 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:42543.26 Median:22694.54 stddev:122572.08 (540.1%) stddev-sans-first:122875.00 01:53:59 INFO - PROCESS | 1648 | Values: 362.4 381.7 389.6 408.8 424.1 13305.5 15755.7 20820.0 22508.9 22880.2 19291.7 19663.8 20027.9 20158.0 22129.0 6479.8 6821.1 6825.4 6829.5 6830.6 7503.8 7871.5 8001.1 8008.6 8021.8 6625.3 7711.4 7988.9 7994.4 8000.6 7582.4 8003.8 8008.0 8065.5 8082.4 7570.0 7886.8 7904.2 7935.5 7949.0 29779.9 30189.8 30261.4 30405.7 30601.7 2866.0 2915.9 3060.7 3080.3 3098.4 16608.3 17325.0 17850.9 18465.3 18557.4 2013.4 2032.6 2043.1 2047.3 2114.4 131646.0 144766.3 145884.0 156895.0 162650.2 17043.7 23009.5 23647.0 23712.0 23849.6 42655.0 42779.8 43266.8 43791.6 43849.8 11395.5 11579.5 11607.1 11616.0 11794.7 9063.9 9091.3 9126.4 9154.1 9272.7 9236.3 11255.0 11355.6 11388.0 11525.8 3494.4 4266.8 4298.7 4311.1 4315.9 926.8 940.6 970.0 976.3 980.4 15388.0 19339.5 20566.8 20581.1 20650.0 846.9 947.1 980.4 991.2 998.3 9993.9 10693.8 10773.5 10773.8 10777.4 726448.0 727197.0 738970.0 740117.0 754713.0 125385.0 134851.3 138703.6 142837.6 145011.0 1104.2 1108.5 1164.9 1165.6 1166.2 17629.1 17690.3 18113.9 18151.5 18408.5 61195.0 61262.0 61592.0 61684.7 62502.4 83700.6 84611.0 86044.1 88008.0 88912.6 10796.9 11022.6 11283.9 11286.7 11405.1 11046.4 11170.8 12087.5 12349.7 12407.1 10441.5 10449.8 10593.0 10757.2 10772.9 9858.7 10000.4 10034.9 10102.6 10174.3 8691.3 10667.7 11314.3 11416.4 11768.8 11280.7 11553.9 11931.4 12017.8 12019.5 10917.5 11050.4 11091.0 11187.5 11370.0 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:6636.89 Median:2358.24 stddev:4223.57 (179.1%) stddev-sans-first:4216.31 01:53:59 INFO - PROCESS | 1648 | Values: 1290.8 1551.9 1575.4 1594.8 1598.8 10598.9 11178.9 11205.3 11242.7 11253.4 10719.3 10990.3 11019.9 11190.9 11216.6 2325.7 2352.2 2358.2 2358.3 2363.6 2268.9 2344.8 2347.4 2349.7 2351.1 2215.0 2260.8 2266.9 2315.9 2332.3 2252.7 2319.5 2321.2 2324.6 2324.6 2310.3 2311.6 2315.3 2320.0 2327.4 11160.8 11264.8 11266.8 11274.5 11339.6 5349.7 5521.7 5521.7 5526.7 5532.3 3180.8 3252.0 3411.8 3479.5 3487.6 1143.0 1156.0 1166.0 1173.6 1193.5 13769.5 14167.8 14355.1 15626.1 15641.5 3720.7 3761.8 4111.1 4249.3 4445.3 11872.9 11895.3 11909.2 11916.3 11919.0 5419.5 5446.7 5450.6 5453.9 5475.5 4773.3 5018.9 5073.3 5075.3 5102.8 3550.5 3662.4 3683.9 3724.9 3759.3 910.7 913.8 922.9 925.4 927.9 787.2 807.8 808.5 822.7 843.3 6332.1 6489.3 6594.2 6606.4 6618.6 954.8 1044.5 1044.7 1048.0 1078.0 4106.2 4112.0 4146.5 4232.7 4248.0 10758.6 13425.3 13585.9 13794.1 13927.9 13101.6 13793.6 13794.4 13797.0 13823.7 9644.7 10005.5 10038.7 10052.8 10057.5 6769.6 6774.1 6874.5 6956.0 7040.1 11603.7 12268.9 12298.0 12455.3 12619.4 10608.9 11221.2 12603.4 12850.0 12856.5 9122.5 9309.3 9354.1 9405.9 9438.6 10194.0 10282.5 10319.4 10401.9 10448.0 8837.3 8857.2 8915.6 8917.9 8953.6 8517.5 8568.7 8654.2 8661.7 8694.9 7860.5 7875.2 7888.2 7947.9 7983.5 5049.0 5413.9 5732.9 5789.7 6031.3 5010.5 5106.4 5793.2 5974.3 6001.0 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4393.41 Median:4726.97 stddev:1231.66 (26.1%) stddev-sans-first:1196.10 01:53:59 INFO - PROCESS | 1648 | Values: 295.9 359.1 377.3 378.7 383.3 4179.6 4781.9 4984.9 5026.4 5059.8 4587.4 4686.7 4696.2 4905.4 4992.5 3365.6 3533.3 4092.3 4164.6 4182.3 3674.8 4178.8 4179.9 4203.3 4220.3 3931.0 4066.0 4103.2 4147.6 4157.9 3331.5 3488.6 4061.2 4074.8 4164.8 3359.4 3528.9 3813.1 3817.5 3851.4 3937.6 4267.8 4633.4 4852.2 4894.0 4673.9 4792.5 4820.6 4837.5 4861.4 4341.2 4660.2 5296.4 5335.7 5408.2 3960.8 4267.1 4275.4 4282.5 4313.4 4651.3 5159.9 5416.4 5420.8 5713.0 3911.3 4223.8 4336.1 4360.2 4370.6 3990.6 4268.0 4306.2 4467.4 4569.5 4533.0 4604.6 4627.1 4757.7 4873.8 4846.3 5247.7 5300.2 5324.9 5326.5 1259.7 1358.1 1386.0 1471.8 1495.8 1010.7 1042.6 1066.6 1133.7 1160.6 4424.7 4767.3 4916.0 4963.6 4980.8 5135.7 5396.4 5460.2 5469.8 5481.3 3982.7 4902.9 4919.3 4949.0 5184.9 2569.0 2772.9 2798.3 2884.6 2887.6 4916.3 5525.7 5625.9 5650.7 5726.5 4515.6 5028.1 5563.6 5566.9 5652.6 5131.9 5235.5 5730.6 5746.5 5749.2 4603.9 4768.8 4807.6 5531.3 5543.2 4470.4 5187.5 5424.3 5473.4 5528.8 4759.9 5256.7 5264.4 5553.9 5560.6 3899.8 4113.0 4448.2 4451.8 4484.3 4547.7 5128.9 5138.6 5337.9 5526.7 4060.5 4871.6 4945.1 5059.5 5135.3 4315.7 4617.5 5240.7 5298.5 5304.7 4251.7 4878.9 5170.6 5256.3 5309.9 4495.6 5270.4 5292.6 5318.6 5388.2 4419.8 5195.3 5198.9 5199.6 5202.4 01:53:59 INFO - PROCESS | 1648 | 01:53:59 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20897.06 Median:3607.06 stddev:29987.46 (831.4%) stddev-sans-first:30033.29 01:53:59 INFO - PROCESS | 1648 | Values: 714.8 717.7 738.1 776.8 839.1 14780.9 15561.8 15564.5 15569.1 15584.2 14032.9 14046.3 14053.9 14083.4 14733.9 928.7 940.2 958.2 960.8 977.8 964.2 966.1 966.3 968.0 968.9 1007.9 1009.8 1009.9 1010.8 1014.8 1003.6 1006.0 1006.3 1007.9 1009.2 746.3 749.1 749.1 749.7 751.4 15564.6 15747.7 15765.1 16038.3 16302.8 13277.2 13894.3 13977.5 14067.4 14139.8 11559.4 11796.0 11819.9 11832.7 12012.9 3563.3 3618.2 3710.5 3748.5 3834.0 99447.5 104326.0 104394.0 104699.4 108272.0 10590.9 10670.1 10711.0 10762.5 10772.9 21889.9 21987.2 21990.3 22348.0 22433.9 7294.0 7357.1 7695.5 7724.3 7821.5 4185.6 4206.5 4265.7 4313.6 4449.5 3503.7 3559.2 3600.9 3605.6 3608.5 617.9 655.5 656.9 658.0 658.4 643.4 675.4 680.3 688.4 700.4 8855.0 9478.5 10205.8 10297.3 10543.2 645.2 680.4 686.6 693.4 713.1 4610.8 4941.2 4948.4 4948.7 4956.2 98657.0 104083.9 105228.0 106760.0 110247.0 83591.7 88986.3 91641.0 92653.0 92663.5 81463.6 81468.2 82186.2 82978.2 84830.3 9481.8 9601.6 9602.7 9704.6 9865.6 50490.7 50927.2 52178.7 53321.9 53372.5 67010.7 69807.7 70287.6 75446.9 77587.2 11143.3 12082.5 14048.7 14206.1 14206.9 14774.8 14777.6 15331.4 15347.3 15381.2 13484.9 13735.3 14278.5 14287.6 14382.7 13747.9 13955.4 14260.0 14283.6 14598.6 13523.9 13826.9 14020.5 14287.4 14492.0 8435.5 9043.9 9665.5 9997.6 9997.8 11377.4 11390.2 11602.3 11740.7 11805.5 01:53:59 INFO - PROCESS | 1648 | -------- Summary: end -------- 01:53:59 INFO - PROCESS | 1648 | 01:54:00 INFO - TEST-INFO | 1648: exit 0 01:54:00 INFO - TEST-OK | dromaeo_css | took 1120701ms 01:54:00 INFO - TEST-START | kraken 01:54:00 INFO - operating with platform_type : mac_ 01:54:00 INFO - Initialising browser for kraken test... 01:54:00 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpgCOTf4/profile http://localhost:49242/getInfo.html) 01:54:02 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 01:54:02 INFO - PROCESS | 1653 | colorDepth:24 01:54:02 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 01:54:02 INFO - PROCESS | 1653 | __metrics 01:54:03 INFO - PROCESS | 1653 | 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" 01:54:03 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:54:03 INFO - TEST-INFO | 1653: exit 0 01:54:03 INFO - Browser initialized. 01:54:03 INFO - Running cycle 1/1 for kraken test... 01:54:03 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/tmpgCOTf4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:15 INFO - PROCESS | 1655 | RSS: Main: 215101440 01:54:15 INFO - PROCESS | 1655 | 01:54:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:19 INFO - PROCESS | 1655 | RSS: Main: 268066816 01:54:19 INFO - PROCESS | 1655 | 01:54:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 01:54:22 INFO - PROCESS | 1655 | RSS: Main: 278634496 01:54:22 INFO - PROCESS | 1655 | 01:54:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 01:54:26 INFO - PROCESS | 1655 | RSS: Main: 375164928 01:54:26 INFO - PROCESS | 1655 | 01:54:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 01:54:29 INFO - PROCESS | 1655 | RSS: Main: 278851584 01:54:29 INFO - PROCESS | 1655 | 01:54:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:31 INFO - PROCESS | 1655 | RSS: Main: 280477696 01:54:31 INFO - PROCESS | 1655 | 01:54:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:35 INFO - PROCESS | 1655 | RSS: Main: 321097728 01:54:35 INFO - PROCESS | 1655 | 01:54:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:39 INFO - PROCESS | 1655 | RSS: Main: 321974272 01:54:39 INFO - PROCESS | 1655 | 01:54:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 01:54:42 INFO - PROCESS | 1655 | RSS: Main: 318472192 01:54:42 INFO - PROCESS | 1655 | 01:54:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:54:44 INFO - PROCESS | 1655 | RSS: Main: 294690816 01:54:44 INFO - PROCESS | 1655 | 01:54:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:54:47 INFO - PROCESS | 1655 | RSS: Main: 300027904 01:54:47 INFO - PROCESS | 1655 | 01:54:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:54:50 INFO - PROCESS | 1655 | RSS: Main: 302649344 01:54:50 INFO - PROCESS | 1655 | 01:54:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:54:53 INFO - PROCESS | 1655 | RSS: Main: 319524864 01:54:53 INFO - PROCESS | 1655 | 01:54:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:54:57 INFO - PROCESS | 1655 | RSS: Main: 313802752 01:54:57 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 01:54:59 INFO - PROCESS | 1655 | RSS: Main: 358244352 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | __start_tp_report 01:54:59 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 01:54:59 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 01:54:59 INFO - PROCESS | 1655 | |i|pagename|runs| 01:54:59 INFO - PROCESS | 1655 | |0;ai-astar;117;115;116;115;116;115;117;114;117;116 01:54:59 INFO - PROCESS | 1655 | |1;audio-beat-detection;143;111;109;144;106;109;110;110;129;109 01:54:59 INFO - PROCESS | 1655 | |2;audio-dft;184;184;184;183;186;185;180;184;184;185 01:54:59 INFO - PROCESS | 1655 | |3;audio-fft;83;61;59;93;64;62;61;61;80;74 01:54:59 INFO - PROCESS | 1655 | |4;audio-oscillator;89;70;87;70;69;68;82;68;69;84 01:54:59 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;95;89;94;95;92;94;92;89;95;89 01:54:59 INFO - PROCESS | 1655 | |6;imaging-darkroom;113;153;96;96;96;96;97;95;96;96 01:54:59 INFO - PROCESS | 1655 | |7;imaging-desaturate;84;83;85;83;84;84;83;86;83;85 01:54:59 INFO - PROCESS | 1655 | |8;json-parse-financial;64;61;60;62;64;66;64;65;64;63 01:54:59 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;60;58;56;64;60;57;58;58;59;59 01:54:59 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;83;82;83;85;85;82;82;82;85;82 01:54:59 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;139;138;145;146;134;147;164;144;201;180 01:54:59 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;201;221;171;165;162;166;164;169;193;149 01:54:59 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;65;67;65;65;65;65;64;64;65;63 01:54:59 INFO - PROCESS | 1655 | __end_tp_report 01:54:59 INFO - PROCESS | 1655 | __start_cc_report 01:54:59 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2238 01:54:59 INFO - PROCESS | 1655 | __end_cc_report 01:54:59 INFO - PROCESS | 1655 | __startTimestamp1490518499538__endTimestamp 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | ------- Summary: start ------- 01:54:59 INFO - PROCESS | 1655 | Number of tests: 14 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 01:54:59 INFO - PROCESS | 1655 | Values: 117.0 115.0 116.0 115.0 116.0 115.0 117.0 114.0 117.0 116.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:110.50 stddev:14.85 (13.4%) stddev-sans-first:12.71 01:54:59 INFO - PROCESS | 1655 | Values: 143.0 111.0 109.0 144.0 106.0 109.0 110.0 110.0 129.0 109.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.60 (0.9%) stddev-sans-first:1.69 01:54:59 INFO - PROCESS | 1655 | Values: 184.0 184.0 184.0 183.0 186.0 185.0 180.0 184.0 184.0 185.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:69.80 Median:69.00 stddev:11.91 (17.3%) stddev-sans-first:11.64 01:54:59 INFO - PROCESS | 1655 | Values: 83.0 61.0 59.0 93.0 64.0 62.0 61.0 61.0 80.0 74.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.00 stddev:8.73 (11.5%) stddev-sans-first:7.80 01:54:59 INFO - PROCESS | 1655 | Values: 89.0 70.0 87.0 70.0 69.0 68.0 82.0 68.0 69.0 84.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:94.00 stddev:2.59 (2.8%) stddev-sans-first:2.57 01:54:59 INFO - PROCESS | 1655 | Values: 95.0 89.0 94.0 95.0 92.0 94.0 92.0 89.0 95.0 89.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:96.00 stddev:18.23 (19.0%) stddev-sans-first:19.01 01:54:59 INFO - PROCESS | 1655 | Values: 113.0 153.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.05 (1.3%) stddev-sans-first:1.12 01:54:59 INFO - PROCESS | 1655 | Values: 84.0 83.0 85.0 83.0 84.0 84.0 83.0 86.0 83.0 85.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.92 01:54:59 INFO - PROCESS | 1655 | Values: 64.0 61.0 60.0 62.0 64.0 66.0 64.0 65.0 64.0 63.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:2.18 (3.7%) stddev-sans-first:2.28 01:54:59 INFO - PROCESS | 1655 | Values: 60.0 58.0 56.0 64.0 60.0 57.0 58.0 58.0 59.0 59.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.37 (1.7%) stddev-sans-first:1.45 01:54:59 INFO - PROCESS | 1655 | Values: 83.0 82.0 83.0 85.0 85.0 82.0 82.0 82.0 85.0 82.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:146.50 stddev:21.50 (14.7%) stddev-sans-first:22.13 01:54:59 INFO - PROCESS | 1655 | Values: 139.0 138.0 145.0 146.0 134.0 147.0 164.0 144.0 201.0 180.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:170.00 stddev:21.87 (12.9%) stddev-sans-first:21.25 01:54:59 INFO - PROCESS | 1655 | Values: 201.0 221.0 171.0 165.0 162.0 166.0 164.0 169.0 193.0 149.0 01:54:59 INFO - PROCESS | 1655 | 01:54:59 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 01:54:59 INFO - PROCESS | 1655 | Values: 65.0 67.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 63.0 01:54:59 INFO - PROCESS | 1655 | -------- Summary: end -------- 01:54:59 INFO - PROCESS | 1655 | 01:55:00 INFO - TEST-INFO | 1655: exit 0 01:55:00 INFO - TEST-OK | kraken | took 59882ms 01:55:00 INFO - SUITE-END | took 1180s 01:55:00 INFO - Completed test suite (00:19:40) 01:55:00 INFO - javascript benchmark 01:55:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7619.600457108603, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2932.9999999999995, 3407.454807230842, 3417.453207486802, 3434.605020422649, 3462.1344663834043, 4644.489106198315, 5965.940340596593, 5990.520758339333, 6022.789202377918, 6065.69671516424, 5995.6102853314505, 6050.909236361458, 6057.36397678243, 6074.848128796772, 6081.847953801157, 5380.838574842751, 5404.4595540446035, 5438.401775804658, 5509.311336082989, 5534.0, 5296.576273898098, 5307.973460132714, 5518.475744804237, 5530.557555395559, 5533.335999680044, 5349.652272602269, 5406.945930540704, 5416.241726158341, 5424.891502169974, 5440.972795136019, 5415.079436495786, 5415.83752487426, 5426.67439953604, 5429.0, 5431.131019036935, 5234.6335756497065, 5357.008953343644, 5358.276632654581, 5367.382750983647, 5383.246345511592, 6010.789622363196, 6016.8495787605225, 6020.8494787630225, 6023.367546407608, 6030.427109424598, 6305.8108256752375, 6342.904856427157, 6343.302236753953, 6351.491880649537, 6364.045393191012, 6302.054691796221, 6331.683415829236, 6387.0, 6456.580322279036, 6501.0, 4760.809567617292, 6148.754049838001, 6153.323134455206, 6158.907616385713, 6165.907511387288, 6321.810345689637, 6552.541322107454, 6596.142501474777, 6615.239247486505, 6625.469962402996, 5266.34170728659, 6258.3741625837965, 6275.309715931244, 6310.936890631035, 6321.051842223703, 6472.967635161794, 6495.8700825983215, 6496.935030649633, 6508.739650414025, 6511.544191906616, 6360.904586431115, 6374.171357723466, 6390.201224846895, 6392.648404337806, 6393.776217832354, 6115.553609370865, 6339.841503962438, 6369.14016607752, 6387.552871298964, 6392.616443013434, 4318.805653745589, 5081.72050537224, 5135.948640513547, 5176.0, 5185.092608793521, 4587.105514424722, 4598.1033698429155, 4629.814807407666, 4642.187617166982, 4665.346851440801, 6061.818145455643, 6083.062376573406, 6089.360617135137, 6107.725152368154, 6111.174991376108, 6291.339409362043, 6331.335209802996, 6351.460125889259, 6451.774187903401, 6512.641804700692, 5880.235569375954, 5884.794032208938, 5895.55783316253, 5904.321003084614, 5913.526917846562, 5602.719864006784, 5607.243022192033, 5608.775648974077, 5608.9439105609235, 5627.324721033502, 6416.454601358843, 6499.38255865692, 6511.999999999905, 6569.737210511526, 6611.173603299588, 6499.155109835691, 6500.577462464925, 6505.154329937267, 6512.73949042033, 6534.869302614016, 6697.296783837627, 6697.497687673346, 6711.697973591297, 6717.764878229238, 6723.932760672331, 6231.3145553988115, 6291.087792270004, 6302.054691796267, 6421.0, 6437.25971513282, 6186.690665466798, 6299.527535434769, 6326.6836658165985, 6329.873402531832, 6339.207599050119, 6251.187345645037, 6275.592086514362, 6335.968320158369, 6336.239651241881, 6356.650384228727, 6310.463610592968, 6326.6520341381665, 6327.3356297589935, 6329.651869147241, 6342.365763423621, 6286.40279173496, 6290.339514350927, 6304.873902522016, 6312.14786003902, 6322.399372059647, 6090.543209259235, 6093.634381937098, 6121.666376154749, 6242.032484964838, 6252.812415627538, 6308.053791931247, 6313.273973492924, 6317.9052314214405, 6321.1782468278825, 6332.335104814112], "value": 5894.268699032427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.7874834420535, 795.5942469340637, 856.7772379181415, 867.496851825941, 871.6949067826262, 38023.42964855526, 38514.0, 40317.0, 40335.19329613406, 40358.39462408066, 39124.60875391245, 39299.41050884239, 39373.803130984306, 39459.40810887839, 39470.605293947054, 7166.60583667898, 9021.323400744937, 9190.264778817678, 9190.540472976358, 9214.585343659517, 6198.44214020738, 10751.462426878665, 11038.503267352988, 11143.888561114367, 11160.609378671748, 10948.45257737114, 11006.174536909724, 11020.724481887977, 11049.613263535777, 11052.723681907977, 10926.890731092666, 10951.288166269167, 10953.561857525729, 10974.024675558396, 10978.0, 6204.317525072239, 7347.7795666130105, 7382.040334756501, 7383.187849336568, 7395.149557800814, 36929.630703692885, 37553.0, 38824.41763373552, 39115.6309529168, 39144.80427597872, 3744.719146064056, 3783.39465685489, 3787.734858559902, 3799.772013679188, 3840.0399900024995, 26187.345316367053, 26322.6051609226, 26705.33236669099, 27359.0, 28088.578671319945, 2984.567237750514, 3000.5499175123905, 3058.0672894767085, 3227.644959054502, 3233.175540237248, 367543.0, 370427.0, 370763.0, 371322.0, 372428.13785931165, 42957.35563966543, 43167.78416107899, 43208.0, 43350.0, 43372.132557348676, 43333.91665208332, 43466.56533434689, 43474.0, 43481.0, 43488.0, 12932.030097742707, 13231.20612763218, 13238.73522529544, 13252.0, 13269.0, 9652.565634546463, 11739.47172377245, 11755.471003804849, 11755.529778808923, 11755.823662645067, 10702.625408110678, 11173.0, 11334.036606888341, 11464.426778661034, 11464.713382165346, 4666.486686464486, 5447.521248224075, 5562.638428502134, 5574.303212098488, 5609.915851262234, 1048.2598885849454, 1066.9970227985668, 1086.6196831109048, 1131.5247596009697, 1136.5851464215666, 21809.563808724055, 24327.513449730905, 25170.74829251684, 25370.365740856625, 25435.872820635777, 984.9461076648062, 1179.2334982261427, 1179.351356753782, 1191.398343836357, 1219.670688914006, 12841.678958026125, 12980.912763967111, 12999.480020799252, 13022.609321720363, 13138.211707297593, 463691.0, 464167.0, 466368.0, 469787.0, 479518.0, 55273.0, 55837.441625583226, 55871.441285586625, 55936.440635593935, 55963.44036559664, 1198.8920997110301, 1253.2981530343036, 1399.846016938136, 1462.1300326305832, 1462.648964248594, 23312.76687233106, 27105.051323203592, 28697.995570154944, 28754.281142971595, 29465.55801662934, 51767.705807355116, 51990.74004629953, 52058.0, 52085.7395713019, 52098.21852672137, 461520.6923965359, 465952.0, 466104.6694766504, 466382.0, 468449.0, 30742.846285768428, 31100.0, 31183.064508064796, 31319.84340078285, 31393.68606313999, 43206.50687826008, 44546.77726611346, 44632.33051504295, 44760.328595071755, 44791.0, 28474.57288140638, 29773.255668608457, 30148.24629384283, 30682.0, 30693.53959690651, 28063.0, 30089.849550752107, 30404.0, 30483.0, 30724.92462763882, 35047.0, 35678.4648230282, 36408.27183456263, 36458.63541364658, 36619.08452288714, 24374.634380484662, 29868.0, 30097.0, 30197.09408717742, 30752.923647672225, 21921.780782191974, 22084.116635334405, 23046.884765576066, 23458.296251112493, 23554.88222558876], "value": 18151.860064870467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4147002590815, 381.7404165167685, 389.60649743758796, 408.79968815280523, 424.0501277139208, 13305.534306299269, 15755.68488630228, 20819.959002049894, 22508.88745556274, 22880.199193028246, 19291.710624340645, 19663.803361966377, 20027.89986050068, 20158.0, 22129.0, 6479.805605831821, 6821.113255276832, 6825.419839313639, 6829.521933464659, 6830.590164590116, 7503.849923001564, 7871.5277083374895, 8001.1198768135455, 8008.55952922589, 8021.799455013613, 6625.337466253361, 7711.4216433767415, 7988.920110798905, 7994.360451163922, 8000.559969201691, 7582.431317651198, 8003.839923201504, 8007.959960200191, 8065.475744076616, 8082.353411727047, 7570.0, 7886.763397098096, 7904.1700621435075, 7935.523868567847, 7949.0, 29779.851100744574, 30189.849050754605, 30261.394772104653, 30405.695943040508, 30601.693983060108, 2865.9856700716573, 2915.9125226243245, 3060.709232622897, 3080.3377273886, 3098.395812816502, 16608.25262863174, 17325.0, 17850.91074544619, 18465.261389544536, 18557.35049273269, 2013.416109328293, 2032.5934813037452, 2043.1010355443557, 2047.2732180076157, 2114.397396741921, 131646.0, 144766.2761686185, 145884.0, 156895.0, 162650.1867490655, 17043.659126817394, 23009.53980920372, 23647.0, 23711.968965275944, 23849.642255366183, 42655.0, 42779.786101069294, 43266.783666081465, 43791.56208437875, 43849.78075109604, 11395.487203075882, 11579.478923448465, 11607.071434285237, 11616.012638925617, 11794.705132371759, 9063.864042039375, 9091.31815113869, 9126.406783559047, 9154.130357616015, 9272.72181834546, 9236.307276954256, 11255.0, 11355.602553910574, 11388.0, 11525.76948461026, 3494.3884820156372, 4266.786660666954, 4298.720583162084, 4311.137772445523, 4315.870523884289, 926.8331700293877, 940.6190492850407, 969.9951500242454, 976.2970661123979, 980.3823591137538, 15388.0, 19339.51651208731, 20566.794332056787, 20581.07385167671, 20650.0, 846.9280111190618, 947.1475671895349, 980.4264505264357, 991.2119864707574, 998.2912132385942, 9993.900060999296, 10693.78612427747, 10773.515191816387, 10773.83839242412, 10777.353358798497, 726448.0, 727197.0, 738970.0, 740117.0, 754713.0, 125385.0, 134851.3257433726, 138703.6129638711, 142837.57230924634, 145011.0, 1104.1773878460438, 1108.4956344863228, 1164.8776878427811, 1165.5687395663658, 1166.2361153444508, 17629.118544072488, 17690.292388304322, 18113.909430452764, 18151.546211344295, 18408.539786505444, 61195.0, 61262.0, 61592.0, 61684.69157654183, 62502.37497625148, 83700.58149709456, 84611.0, 86044.13955860361, 88008.0, 88912.5554372224, 10796.892031079902, 11022.559097636326, 11283.887161128283, 11286.66140015801, 11405.087592992706, 11046.447677616248, 11170.832437513282, 12087.456064476944, 12349.69125771827, 12407.131500795218, 10441.477926103817, 10449.791004180026, 10593.0, 10757.193210509087, 10772.946135269274, 9858.704238872846, 10000.44997525114, 10034.949825250827, 10102.646407375707, 10174.287799853939, 8691.304695624462, 10667.679969600924, 11314.264572802742, 11416.429178540873, 11768.823467648162, 11280.717982050515, 11553.94223028913, 11931.4034298283, 12017.819732703842, 12019.519219231133, 10917.508712108132, 11050.447477625925, 11091.0, 11187.496562654864, 11370.0], "value": 11777.308596917024, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.8321918150646, 1551.9146446945413, 1575.3855996161499, 1594.792676951996, 1598.7841641378413, 10598.894011059887, 11178.944105279463, 11205.271657342268, 11242.66272011839, 11253.381064041474, 10719.303245289051, 10990.340579565212, 11019.944900275488, 11190.944045279783, 11216.551337946472, 2325.697659304288, 2352.188494969233, 2358.2099996501192, 2358.2689366296504, 2363.621820508719, 2268.852524585897, 2344.788968992799, 2347.424880904181, 2349.659299401594, 2351.1065794997876, 2214.9889250553724, 2260.7513173550897, 2266.9206577769783, 2315.8610483370967, 2332.3003099070297, 2252.650839119939, 2319.489712263299, 2321.2339927823778, 2324.5583339165587, 2324.639680849471, 2310.330004298751, 2311.5723591135693, 2315.3169814904645, 2320.002398968443, 2327.394877331889, 11160.832587511193, 11264.774704505864, 11266.830997535044, 11274.492647830868, 11339.603113891057, 5349.7057661828585, 5521.723913804293, 5521.723913804334, 5526.668399896019, 5532.336119665666, 3180.8250546219947, 3252.0, 3411.829408529564, 3479.530263414432, 3487.5814902211896, 1143.034136154956, 1155.9768804623861, 1165.9883401165964, 1173.6303064534645, 1193.516625766566, 13769.518066867711, 14167.787483187658, 14355.138691678429, 15626.14056226907, 15641.452549160838, 3720.6651401374006, 3761.7962252079074, 4111.09555897702, 4249.32010878258, 4445.333200019958, 11872.931436170613, 11895.345755983504, 11909.22590031645, 11916.285022898654, 11919.046476281877, 5419.512243898068, 5446.700431476307, 5450.618456707993, 5453.945460545344, 5475.534579560703, 4773.307870358779, 5018.949810501921, 5073.264376665436, 5075.264086707407, 5102.846914592568, 3550.5384300041346, 3662.3957047087465, 3683.889483315505, 3724.944125838115, 3759.342115129841, 910.7313342563959, 913.8126684029758, 922.8800255966815, 925.3892430995511, 927.8608208768603, 787.169536139367, 807.8182408957938, 808.4785313472777, 822.7284995951321, 843.3169133002287, 6332.145160403286, 6489.318621544764, 6594.175728033996, 6606.405423511907, 6618.63597502142, 954.8233576788316, 1044.5090807320548, 1044.6761503933806, 1048.0410424461531, 1077.956881724738, 4106.2198182345255, 4111.958880411217, 4146.523149837747, 4232.703710740218, 4247.97876010618, 10758.623448179276, 13425.328733563478, 13585.932070339584, 13794.103383280055, 13927.860721392859, 13101.606951791462, 13793.586192414243, 13794.37925293344, 13796.965227607969, 13823.654408639864, 9644.710658680251, 10005.49972501372, 10038.74903127413, 10052.849207261897, 10057.547410366551, 6769.627670477974, 6774.085498457645, 6874.484413668894, 6955.965220173866, 7040.119985001875, 11603.709907252387, 12268.877311226774, 12298.016158707103, 12455.343536242224, 12619.369031548202, 10608.89391106079, 11221.158413119212, 12603.369831508571, 12850.036247281305, 12856.485740570273, 9122.498262595622, 9309.348345615741, 9354.111359420844, 9405.85891211646, 9438.575264112995, 10193.980601939747, 10282.537285822007, 10319.380837149794, 10401.895981040092, 10448.0, 8837.337199709918, 8857.247133993682, 8915.598798053974, 8917.866232006654, 8953.597088130919, 8517.531535765593, 8568.657253709782, 8654.177853103945, 8661.740147795575, 8694.869576956224, 7860.489068210548, 7875.173106823701, 7888.17174196724, 7947.8807817881625, 7983.5209887406945, 5048.974755126201, 5413.891722165614, 5732.856678583069, 5789.739461724148, 6031.336552979081, 5010.49895010496, 5106.438291787975, 5793.15999180125, 5974.342822289632, 6001.0], "value": 5004.422122944667, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9067893613512, 359.1326945426794, 377.32270574319097, 378.6573151298076, 383.2794346628338, 4179.644730197933, 4781.900162962512, 4984.850454486371, 5026.447090820011, 5059.772310246043, 4587.357769912215, 4686.71879687219, 4696.248600223965, 4905.41135063792, 4992.475790042039, 3365.5793025871767, 3533.2617221653295, 4092.3452247640457, 4164.583541645827, 4182.285263042153, 3674.8346324415334, 4178.767263657213, 4179.91640167198, 4203.26442872496, 4220.324748040314, 3931.0, 4066.0, 4103.158852435258, 4147.6474499667565, 4157.875263742093, 3331.4669652855546, 3488.6336934621754, 4061.208064427423, 4074.8166332515107, 4164.7709375984305, 3359.445691460906, 3528.947065794015, 3813.0657988792923, 3817.522809648794, 3851.4030325299345, 3937.6415136777764, 4267.8079486423185, 4633.374494443241, 4852.2289364382095, 4894.021195760826, 4673.948361618643, 4792.48394592838, 4820.590249828769, 4837.516248375169, 4861.440934292531, 4341.218580655481, 4660.184467718136, 5296.417394086686, 5335.67985920846, 5408.161734931092, 3960.8019599019935, 4267.103908179286, 4275.358696195564, 4282.451941095043, 4313.374560688682, 4651.279051746985, 5159.896802063938, 5416.350037995466, 5420.810271640474, 5713.028785106542, 3911.2568611963634, 4223.809928553223, 4336.132773445323, 4360.193364227628, 4370.628496577763, 3990.620891015349, 4267.997020700133, 4306.181825453154, 4467.419235499365, 4569.543045695404, 4533.0, 4604.58558729716, 4627.079761898842, 4757.691634800458, 4873.829415970495, 4846.32329801743, 5247.737613119405, 5300.16441203954, 5324.893502129936, 5326.467353264643, 1259.7354555543254, 1358.1443690475135, 1386.0228538880065, 1471.837248573615, 1495.8055452791068, 1010.6709676775017, 1042.5985995391677, 1066.568039943824, 1133.7165708572857, 1160.5763896178003, 4424.734515929054, 4767.284907263869, 4916.0, 4963.6277279204205, 4980.7509624518625, 5135.7388058583065, 5396.4333744957, 5460.180972854104, 5469.808556700496, 5481.260029895913, 3982.661473774762, 4902.8774280643265, 4919.311296418504, 4949.0, 5184.870378240575, 2568.961465578018, 2772.875220615077, 2798.272449163232, 2884.5961565380862, 2887.63904511936, 4916.2625606158645, 5525.668459892419, 5625.862172374472, 5650.689212093293, 5726.455986681259, 4515.593596576258, 5028.094942910238, 5563.582731295169, 5566.888662226733, 5652.576056795757, 5131.867418434935, 5235.528802407802, 5730.570207234474, 5746.454086861741, 5749.1663708762, 4603.895065184399, 4768.809247630056, 4807.567318941312, 5531.321671088842, 5543.223948647112, 4470.396496472935, 5187.481251874782, 5424.267723857387, 5473.397926228032, 5528.806491772769, 4759.881002974953, 5256.684598924076, 5264.394594621667, 5553.889521981621, 5560.555155587463, 3899.8440062397185, 4113.0, 4448.243798554318, 4451.775761665568, 4484.349769283501, 4547.749873756843, 5128.871778205575, 5138.640295179451, 5337.866553336197, 5526.668399895858, 4060.5127384714024, 4871.63462740303, 4945.060438516671, 5059.519345662156, 5135.270040930359, 4315.676324275629, 4617.46899106607, 5240.71176085319, 5298.523132918056, 5304.7082410466255, 4251.744895306291, 4878.90242195147, 5170.560502357342, 5256.290400795843, 5309.893802124013, 4495.617872480745, 5270.393904701008, 5292.6127278541, 5318.574514038945, 5388.164834450667, 4419.845305414295, 5195.298634684269, 5198.8960220796125, 5199.63602547818, 5202.358349155531], "value": 4032.7237713076865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8284411741183, 717.6626985316901, 738.0995185873232, 776.8329809091044, 839.0937787189833, 14780.852191478096, 15561.766573501407, 15564.455244066474, 15569.143697096655, 15584.220788960549, 14032.92983535081, 14046.297685115755, 14053.929730351334, 14083.366248518816, 14733.852661473382, 928.6981730937456, 940.2337095267369, 958.2190514730507, 960.7934294126761, 977.8044391121769, 964.2382517810921, 966.0677446264353, 966.2801213096218, 967.9854802177973, 968.8788901387327, 1007.9496025198747, 1009.7980403919208, 1009.9495025248744, 1010.7624708193568, 1014.8071866345408, 1003.6186249225284, 1005.964791232307, 1006.3458751811309, 1007.9143272821746, 1009.1976878381631, 746.2910235276455, 749.1459735901077, 749.1497150733902, 749.7226026370223, 751.4176513202258, 15564.61088472786, 15747.685046299124, 15765.132917689523, 16038.278277477542, 16302.836971630251, 13277.203367797963, 13894.305284735823, 13977.510787122503, 14067.366968486444, 14139.787903181461, 11559.422028898605, 11795.967538036773, 11819.940900295529, 11832.704182395422, 12012.879871201263, 3563.251717139404, 3618.203995121069, 3710.461983012448, 3748.456473811282, 3834.0223243073115, 99447.50276248645, 104325.99999999924, 104394.0, 104699.42950855743, 108272.0, 10590.894091059145, 10670.146388288918, 10711.0, 10762.515686794113, 10772.946135269274, 21889.890550547465, 21987.23044693428, 21990.340289791333, 22348.0, 22433.87830608463, 7294.0, 7357.0803649543805, 7695.538267703956, 7724.3434308083315, 7821.530708157415, 4185.58144185579, 4206.453161089039, 4265.701400901907, 4313.633341165973, 4449.532799056117, 3503.737219708532, 3559.1635965548076, 3600.855965761393, 3605.5853576838476, 3608.530890984208, 617.8733359661259, 655.5476721062452, 656.917885264342, 657.9967100164469, 658.4304576541257, 643.4016364780705, 675.4495086504484, 680.2585182151479, 688.3942130924754, 700.3556727810427, 8854.955725221333, 9478.478683672463, 10205.795884082278, 10297.279190456746, 10543.209259305582, 645.2289514030688, 680.4216416046321, 686.5503095472474, 693.3690341788948, 713.0730050933765, 4610.815567377334, 4941.234108713155, 4948.356713627206, 4948.678335908155, 4956.157453232959, 98657.0, 104083.8774836756, 105228.0, 106760.0, 110247.0, 83591.74612380819, 88986.32216568296, 91641.0, 92653.0, 92663.53668231616, 81463.5926820374, 81468.18531814606, 82186.17813821786, 82978.17021829705, 84830.303393933, 9481.845612773148, 9601.567929443052, 9602.747612713543, 9704.563294651616, 9865.605375784888, 50490.747546262035, 50927.19900405365, 52178.73910630422, 53321.93356132933, 53372.4662753383, 67010.6649466769, 69807.6509617469, 70287.64856175687, 75446.8682969745, 77587.22412776026, 11143.33140011602, 12082.45628946717, 14048.719025619226, 14206.147631142165, 14206.857931420553, 14774.77837832412, 14777.610524067335, 15331.386744530093, 15347.309371078105, 15381.230938452809, 13484.86515134836, 13735.313234338044, 14278.500252491112, 14287.57137285883, 14382.712345752818, 13747.862521374658, 13955.441782328999, 14260.00179987391, 14283.571492855232, 14598.635034124232, 13523.932380338036, 13826.930865345608, 14020.509282175075, 14287.357068931715, 14492.0, 8435.536045517556, 9043.909560904307, 9665.468399237829, 9997.55011024491, 9997.75005624836, 11377.43112844371, 11390.229850805346, 11602.303861767983, 11740.70648233801, 11805.468753906267], "value": 7694.851844465015, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1442.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 116.0, 115.0, 116.0, 115.0, 117.0, 114.0, 117.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 109.0, 144.0, 106.0, 109.0, 110.0, 110.0, 129.0, 109.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 184.0, 183.0, 186.0, 185.0, 180.0, 184.0, 184.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 59.0, 93.0, 64.0, 62.0, 61.0, 61.0, 80.0, 74.0], "value": 69.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 87.0, 70.0, 69.0, 68.0, 82.0, 68.0, 69.0, 84.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 89.0, 94.0, 95.0, 92.0, 94.0, 92.0, 89.0, 95.0, 89.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 153.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 84.0, 84.0, 83.0, 86.0, 83.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 60.0, 62.0, 64.0, 66.0, 64.0, 65.0, 64.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 56.0, 64.0, 60.0, 57.0, 58.0, 58.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 85.0, 85.0, 82.0, 82.0, 82.0, 85.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 145.0, 146.0, 134.0, 147.0, 164.0, 144.0, 201.0, 180.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 221.0, 171.0, 165.0, 162.0, 166.0, 164.0, 169.0, 193.0, 149.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 63.0], "value": 64.8, "unit": "score"}]}]} 01:55:00 INFO - Return code: 0 01:55:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:55:00 ERROR - # TBPL SUCCESS # 01:55:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:55:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:55:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:55:00 INFO - 2017-03-26 01:55:00.864 screenresolution[1659:11574] starting screenresolution argv=screenresolution get 01:55:00 INFO - 2017-03-26 01:55:00.867 screenresolution[1659:11574] Display 0: 1600x1200x32@60 01:55:00 INFO - 2017-03-26 01:55:00.874 screenresolution[1660:11577] starting screenresolution argv=screenresolution list 01:55:00 INFO - Available Modes on Display 0 01:55:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:55:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:55:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:55:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:55:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:55:01 INFO - Intel Iris: 01:55:01 INFO - Chipset Model: Intel Iris 01:55:01 INFO - Type: GPU 01:55:01 INFO - Bus: Built-In 01:55:01 INFO - VRAM (Dynamic, Max): 1536 MB 01:55:01 INFO - Vendor: Intel (0x8086) 01:55:01 INFO - Device ID: 0x0a2e 01:55:01 INFO - Revision ID: 0x0009 01:55:01 INFO - Displays: 01:55:01 INFO - Display: 01:55:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:55:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:55:01 INFO - Display Serial Number: 1600x1200 60 01:55:01 INFO - Main Display: Yes 01:55:01 INFO - Mirror: Off 01:55:01 INFO - Online: Yes 01:55:01 INFO - Rotation: Supported 01:55:01 INFO - Return code: 0 01:55:01 INFO - Running post-action listener: _resource_record_post_action 01:55:01 INFO - [mozharness: 2017-03-26 08:55:01.110746Z] Finished run-tests step (success) 01:55:01 INFO - Running post-run listener: _resource_record_post_run 01:55:01 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32599040; Write bytes: 509855744; Read time: 198; Write time: 1575 01:55:01 INFO - TinderboxPrint: CPU usage
53.8% 01:55:01 INFO - TinderboxPrint: I/O read bytes / time
32,599,040 / 198 01:55:01 INFO - TinderboxPrint: I/O write bytes / time
509,855,744 / 1,575 01:55:01 INFO - TinderboxPrint: CPU idle
2,223.7 (46.2%) 01:55:01 INFO - TinderboxPrint: CPU system
957.8 (19.9%) 01:55:01 INFO - TinderboxPrint: CPU user
1,628.3 (33.9%) 01:55:01 INFO - TinderboxPrint: Swap in / out
236,417,024 / 0 01:55:01 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201542144; Write bytes: 199106560; Read time: 15708; Write time: 421 01:55:01 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31677440; Write bytes: 300845056; Read time: 187; Write time: 1117 01:55:01 INFO - Running post-run listener: _upload_blobber_files 01:55:01 INFO - Blob upload gear active. 01:55:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:55:01 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 01:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 01:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:03 INFO - (blobuploader) - INFO - Done attempting. 01:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:04 INFO - (blobuploader) - INFO - Done attempting. 01:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:06 INFO - (blobuploader) - INFO - Done attempting. 01:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:08 INFO - (blobuploader) - INFO - Done attempting. 01:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 01:55:08 INFO - Return code: 0 01:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84683ee54789b4057b3afb05c0800fbff84366e42c5c3b551869833b8867066180ac3adc4ac026aebe2e42e76d1568210658d379384a72450c50abc7460faa61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70485fc803efad3879b99790d1c921ef40611628b6f5a02e1abd86a95f22b34fc019ec98aafe0e879e4f3c22964a371a93e11241522b4e5925eb965d15d9ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4724a90e40e2c0ea7ae82372d5cc860154dacfd7f658f5c4d190d3e5b302678448ca2d10374639d8e5c5fd746c8ed584eb8686a361acfb3929edb3b7624bccdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f864235f6074182b396a91b6e26eaa19706e09d626177540964971bc4e4da172a8bb80ca6cc08d4e4e2cc4e134b573628fe445109486393c30f91fa7b9b2f65f"} 01:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:55:08 INFO - Contents: 01:55:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84683ee54789b4057b3afb05c0800fbff84366e42c5c3b551869833b8867066180ac3adc4ac026aebe2e42e76d1568210658d379384a72450c50abc7460faa61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70485fc803efad3879b99790d1c921ef40611628b6f5a02e1abd86a95f22b34fc019ec98aafe0e879e4f3c22964a371a93e11241522b4e5925eb965d15d9ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4724a90e40e2c0ea7ae82372d5cc860154dacfd7f658f5c4d190d3e5b302678448ca2d10374639d8e5c5fd746c8ed584eb8686a361acfb3929edb3b7624bccdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f864235f6074182b396a91b6e26eaa19706e09d626177540964971bc4e4da172a8bb80ca6cc08d4e4e2cc4e134b573628fe445109486393c30f91fa7b9b2f65f"} 01:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 01:55:08 INFO - Copying logs to upload dir... 01:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 01:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.192835 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-26 01:55:08.261388) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-26 01:55:08.264412) ========= 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.Ir444pvT8P/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.kghmRfQcjA/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84683ee54789b4057b3afb05c0800fbff84366e42c5c3b551869833b8867066180ac3adc4ac026aebe2e42e76d1568210658d379384a72450c50abc7460faa61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70485fc803efad3879b99790d1c921ef40611628b6f5a02e1abd86a95f22b34fc019ec98aafe0e879e4f3c22964a371a93e11241522b4e5925eb965d15d9ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4724a90e40e2c0ea7ae82372d5cc860154dacfd7f658f5c4d190d3e5b302678448ca2d10374639d8e5c5fd746c8ed584eb8686a361acfb3929edb3b7624bccdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f864235f6074182b396a91b6e26eaa19706e09d626177540964971bc4e4da172a8bb80ca6cc08d4e4e2cc4e134b573628fe445109486393c30f91fa7b9b2f65f"} build_url:https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010717 build_url: 'https://queue.taskcluster.net/v1/task/OnK15jpOT2OXAtx-ajBE_w/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84683ee54789b4057b3afb05c0800fbff84366e42c5c3b551869833b8867066180ac3adc4ac026aebe2e42e76d1568210658d379384a72450c50abc7460faa61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70485fc803efad3879b99790d1c921ef40611628b6f5a02e1abd86a95f22b34fc019ec98aafe0e879e4f3c22964a371a93e11241522b4e5925eb965d15d9ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4724a90e40e2c0ea7ae82372d5cc860154dacfd7f658f5c4d190d3e5b302678448ca2d10374639d8e5c5fd746c8ed584eb8686a361acfb3929edb3b7624bccdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f864235f6074182b396a91b6e26eaa19706e09d626177540964971bc4e4da172a8bb80ca6cc08d4e4e2cc4e134b573628fe445109486393c30f91fa7b9b2f65f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-26 01:55:08.297630) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:55:08.297937) ========= 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.Ir444pvT8P/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.kghmRfQcjA/Listeners TMPDIR=/var/folders/ql/g2ft0_gn4vs3nx5yvzcx9bmh00000w/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.005268 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-26 01:55:08.346747) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-26 01:55:08.347068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-26 01:55:08.347398) ========= ========= Total master_lag: 0.23 =========