builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1489485761.5 results: success (0) buildid: 20170314012636 builduid: 4b7e0e65da894071b9b9f125f43e040a revision: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.504333) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.505084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.505698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.533248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.533996) ========= 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.T1EFubY78C/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.bULyUj2tJN/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-14 03:02:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2017-03-14 03:02:41 (181 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.231685 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.792175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.792550) ========= 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.T1EFubY78C/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.bULyUj2tJN/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.028208 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:41.842262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-14 03:02:41.842626) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 --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 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T1EFubY78C/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.bULyUj2tJN/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-14 03:02:41,945 truncating revision to first 12 chars 2017-03-14 03:02:41,945 Setting DEBUG logging. 2017-03-14 03:02:41,945 attempt 1/10 2017-03-14 03:02:41,945 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/814932cca0c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 03:02:43,693 unpacking tar archive at: mozilla-aurora-814932cca0c4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.009180 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-14 03:02:43.877675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:43.878204) ========= script_repo_revision: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:43.878770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:43.879043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:43.899057) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-14 03:02:43.899621) ========= /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.T1EFubY78C/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.bULyUj2tJN/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:02:44 INFO - MultiFileLogger online at 20170314 03:02:44 in /builds/slave/test 03:02:44 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 03:02:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:02:44 INFO - {'append_to_log': False, 03:02:44 INFO - 'base_work_dir': '/builds/slave/test', 03:02:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:02:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:02:44 INFO - 'branch': 'Mozilla-Aurora', 03:02:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:02:44 INFO - 'config_files': ('talos/mac_config.py',), 03:02:44 INFO - 'default_actions': ('clobber', 03:02:44 INFO - 'read-buildbot-config', 03:02:44 INFO - 'download-and-extract', 03:02:44 INFO - 'populate-webroot', 03:02:44 INFO - 'create-virtualenv', 03:02:44 INFO - 'install', 03:02:44 INFO - 'run-tests'), 03:02:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:02:44 INFO - 'download_minidump_stackwalk': True, 03:02:44 INFO - 'download_symbols': 'ondemand', 03:02:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:02:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:02:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:02:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:02:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:02:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:02:44 INFO - 'gecko_profile': False, 03:02:44 INFO - 'gecko_profile_interval': 0, 03:02:44 INFO - 'installer_path': 'installer.exe', 03:02:44 INFO - 'log_level': 'info', 03:02:44 INFO - 'log_name': 'talos', 03:02:44 INFO - 'log_to_console': True, 03:02:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:02:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:02:44 INFO - 'opt_config_files': (), 03:02:44 INFO - 'pip_index': False, 03:02:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:44 INFO - 'cmd': ('bash', 03:02:44 INFO - '-c', 03:02:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:44 INFO - 'enabled': True, 03:02:44 INFO - 'halt_on_failure': False, 03:02:44 INFO - 'name': 'check_screen_resolution'},), 03:02:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:44 INFO - 'cmd': ('bash', 03:02:44 INFO - '-c', 03:02:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:44 INFO - 'enabled': True, 03:02:44 INFO - 'halt_on_failure': False, 03:02:44 INFO - 'name': 'check_screen_resolution'},), 03:02:44 INFO - 'run_cmd_checks_enabled': True, 03:02:44 INFO - 'suite': 'dromaeojs', 03:02:44 INFO - 'system_bits': '32', 03:02:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:02:44 INFO - 'title': 't-yosemite-r7-0002', 03:02:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:02:44 INFO - 'use_talos_json': True, 03:02:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:02:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:02:44 INFO - 'work_dir': 'build'} 03:02:44 INFO - [mozharness: 2017-03-14 10:02:44.112096Z] Running clobber step. 03:02:44 INFO - Running pre-action listener: _resource_record_pre_action 03:02:44 INFO - Running main action method: clobber 03:02:44 INFO - rmtree: /builds/slave/test/build 03:02:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:02:46 INFO - Running post-action listener: _resource_record_post_action 03:02:46 INFO - [mozharness: 2017-03-14 10:02:46.720333Z] Finished clobber step (success) 03:02:46 INFO - [mozharness: 2017-03-14 10:02:46.720460Z] Running read-buildbot-config step. 03:02:46 INFO - Running pre-action listener: _resource_record_pre_action 03:02:46 INFO - Running main action method: read_buildbot_config 03:02:46 INFO - Using buildbot properties: 03:02:46 INFO - { 03:02:46 INFO - "project": "", 03:02:46 INFO - "product": "firefox", 03:02:46 INFO - "script_repo_revision": "production", 03:02:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:02:46 INFO - "repository": "", 03:02:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:02:46 INFO - "buildid": "20170314012636", 03:02:46 INFO - "pgo_build": "False", 03:02:46 INFO - "basedir": "/builds/slave/test", 03:02:46 INFO - "buildnumber": 86, 03:02:46 INFO - "slavename": "t-yosemite-r7-0002", 03:02:46 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:02:46 INFO - "platform": "yosemite_r7", 03:02:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:02:46 INFO - "branch": "mozilla-aurora", 03:02:46 INFO - "repo_path": "releases/mozilla-aurora", 03:02:46 INFO - "revision": "814932cca0c405b3f95e15fa9b6d4013ccb8cfb1", 03:02:46 INFO - "stage_platform": "macosx64", 03:02:46 INFO - "builduid": "4b7e0e65da894071b9b9f125f43e040a", 03:02:46 INFO - "slavebuilddir": "test" 03:02:46 INFO - } 03:02:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:02:46 INFO - Running post-action listener: _resource_record_post_action 03:02:46 INFO - [mozharness: 2017-03-14 10:02:46.723882Z] Finished read-buildbot-config step (success) 03:02:46 INFO - [mozharness: 2017-03-14 10:02:46.723973Z] Running download-and-extract step. 03:02:46 INFO - Running pre-action listener: _resource_record_pre_action 03:02:46 INFO - Running main action method: download_and_extract 03:02:46 INFO - mkdir: /builds/slave/test/build/tests 03:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:46 INFO - trying https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:02:46 INFO - Downloading https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/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 03:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/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 03:02:47 INFO - Downloaded 1199 bytes. 03:02:47 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:02:47 INFO - Using the following test package requirements: 03:02:47 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:02:47 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:02:47 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:02:47 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'jsshell-mac.zip'], 03:02:47 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:02:47 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:02:47 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:02:47 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:02:47 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:02:47 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:02:47 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:02:47 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:02:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:02:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:02:47 INFO - Fetch https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:02:49 INFO - Expected file size: 51779789 03:02:49 INFO - Obtained file size: 51779789 03:03: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 03:03:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:03:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:04 INFO - Fetch https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:03:06 INFO - Expected file size: 51779789 03:03:06 INFO - Obtained file size: 51779789 03:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:03:22 INFO - Expected file size: 14404424 03:03:22 INFO - Obtained file size: 14404424 03:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:22 INFO - trying https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:03:22 INFO - Downloading https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:03:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/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 03:03:24 INFO - Downloaded 74622826 bytes. 03:03:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:03:24 INFO - mkdir: /builds/slave/test/properties 03:03:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:24 INFO - Contents: 03:03:24 INFO - build_url:https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:03:26 INFO - Running post-action listener: _resource_record_post_action 03:03:26 INFO - Running post-action listener: set_extra_try_arguments 03:03:26 INFO - [mozharness: 2017-03-14 10:03:26.011007Z] Finished download-and-extract step (success) 03:03:26 INFO - [mozharness: 2017-03-14 10:03:26.011153Z] Running populate-webroot step. 03:03:26 INFO - Running pre-action listener: _resource_record_pre_action 03:03:26 INFO - Running main action method: populate_webroot 03:03:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:26 INFO - '--tppagecycles', 03:03:26 INFO - '7'], 03:03:26 INFO - 'tests': ['tsvgm']}}, 03:03:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['damp', 'tps']}, 03:03:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'tests': ['damp', 'tps']}, 03:03:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['dromaeo_dom']}, 03:03:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['basic_compositor_video']}, 03:03:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:03:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['a11yr', 03:03:26 INFO - 'ts_paint', 03:03:26 INFO - 'tpaint', 03:03:26 INFO - 'sessionrestore', 03:03:26 INFO - 'sessionrestore_no_auto_restore', 03:03:26 INFO - 'tabpaint']}, 03:03:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tsvgx', 03:03:26 INFO - 'tsvgr_opacity', 03:03:26 INFO - 'tart', 03:03:26 INFO - 'tscrollx', 03:03:26 INFO - 'cart', 03:03:26 INFO - 'tsvg_static']}, 03:03:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:26 INFO - 'tsvgr_opacity', 03:03:26 INFO - 'tart', 03:03:26 INFO - 'tscrollx', 03:03:26 INFO - 'cart', 03:03:26 INFO - 'tsvg_static']}, 03:03:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s'], 03:03:26 INFO - 'tests': ['tp5o']}, 03:03:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:03:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--disable-e10s', 03:03:26 INFO - '--xperf_path', 03:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:26 INFO - 'tests': ['tp5n']}, 03:03:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:03:26 INFO - 'talos_options': ['--xperf_path', 03:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:26 INFO - 'tests': ['tp5n']}}, 03:03:26 INFO - 'talos.zip': {'path': '', 03:03:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:26 INFO - Running post-action listener: _resource_record_post_action 03:03:26 INFO - [mozharness: 2017-03-14 10:03:26.029563Z] Finished populate-webroot step (success) 03:03:26 INFO - [mozharness: 2017-03-14 10:03:26.029706Z] Running create-virtualenv step. 03:03:26 INFO - Running pre-action listener: _resource_record_pre_action 03:03:26 INFO - Running main action method: create_virtualenv 03:03:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:26 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 03:03:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:26 INFO - Using real prefix '/tools/python27' 03:03:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:29 INFO - Installing pip.................done. 03:03:29 INFO - Return code: 0 03:03:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:03:29 INFO - Reading from file tmpfile_stdout 03:03:29 INFO - Output received: 03:03: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) 03:03:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03: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 03:03: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 03:03:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:29 INFO - 'HOME': '/Users/cltbld', 03:03:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:29 INFO - 'LOGNAME': 'cltbld', 03:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:29 INFO - 'MOZ_NO_REMOTE': '1', 03:03:29 INFO - 'NO_EM_RESTART': '1', 03:03:29 INFO - 'PAGER': '/bin/cat', 03:03:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:29 INFO - 'PWD': '/builds/slave/test', 03:03:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:29 INFO - 'SHELL': '/bin/bash', 03:03:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:29 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:29 INFO - 'USER': 'cltbld', 03:03:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:29 INFO - 'XPC_FLAGS': '0x0', 03:03:29 INFO - 'XPC_SERVICE_NAME': '0', 03:03:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03: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 03:03:30 INFO - Cleaning up... 03:03:30 INFO - Return code: 0 03:03:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03: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 03:03: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 03:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:30 INFO - 'HOME': '/Users/cltbld', 03:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:30 INFO - 'LOGNAME': 'cltbld', 03:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:30 INFO - 'MOZ_NO_REMOTE': '1', 03:03:30 INFO - 'NO_EM_RESTART': '1', 03:03:30 INFO - 'PAGER': '/bin/cat', 03:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:30 INFO - 'PWD': '/builds/slave/test', 03:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:30 INFO - 'SHELL': '/bin/bash', 03:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:30 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:30 INFO - 'USER': 'cltbld', 03:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:30 INFO - 'XPC_FLAGS': '0x0', 03:03:30 INFO - 'XPC_SERVICE_NAME': '0', 03:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:30 INFO - Downloading/unpacking psutil>=3.1.1 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:34 INFO - Installing collected packages: psutil 03:03:34 INFO - Running setup.py install for psutil 03:03:34 INFO - building 'psutil._psutil_osx' extension 03:03: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 03:03: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:03: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:03:34 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 03:03:34 INFO - building 'psutil._psutil_posix' extension 03:03:34 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 03:03:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:03:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:03:35 INFO - ^ 03:03:35 INFO - 1 warning generated. 03:03: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 03:03:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:35 INFO - Successfully installed psutil 03:03:35 INFO - Cleaning up... 03:03:35 INFO - Return code: 0 03:03:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03: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 03:03: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 03:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:35 INFO - 'HOME': '/Users/cltbld', 03:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:35 INFO - 'LOGNAME': 'cltbld', 03:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:35 INFO - 'MOZ_NO_REMOTE': '1', 03:03:35 INFO - 'NO_EM_RESTART': '1', 03:03:35 INFO - 'PAGER': '/bin/cat', 03:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:35 INFO - 'PWD': '/builds/slave/test', 03:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:35 INFO - 'SHELL': '/bin/bash', 03:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:35 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:35 INFO - 'USER': 'cltbld', 03:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:35 INFO - 'XPC_FLAGS': '0x0', 03:03:35 INFO - 'XPC_SERVICE_NAME': '0', 03:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:38 INFO - Installing collected packages: mozsystemmonitor 03:03:38 INFO - Running setup.py install for mozsystemmonitor 03:03:38 INFO - Successfully installed mozsystemmonitor 03:03:38 INFO - Cleaning up... 03:03:38 INFO - Return code: 0 03:03:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:39 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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03:39 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 03:03:39 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 03:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:39 INFO - 'HOME': '/Users/cltbld', 03:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:39 INFO - 'LOGNAME': 'cltbld', 03:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:39 INFO - 'MOZ_NO_REMOTE': '1', 03:03:39 INFO - 'NO_EM_RESTART': '1', 03:03:39 INFO - 'PAGER': '/bin/cat', 03:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:39 INFO - 'PWD': '/builds/slave/test', 03:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:39 INFO - 'SHELL': '/bin/bash', 03:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:39 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:39 INFO - 'USER': 'cltbld', 03:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:39 INFO - 'XPC_FLAGS': '0x0', 03:03:39 INFO - 'XPC_SERVICE_NAME': '0', 03:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:03:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:03:42 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 03:03:42 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 03:03:42 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 03:03:42 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 03:03:42 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 03:03:42 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 03:03:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:03:42 INFO - warning: no files found matching '*.txt' 03:03:42 INFO - no previously-included directories found matching 'build' 03:03:42 INFO - no previously-included directories found matching 'dist' 03:03:42 INFO - no previously-included directories found matching '.git*' 03:03:42 INFO - Installing collected packages: jsonschema, functools32 03:03:42 INFO - Running setup.py install for functools32 03:03:42 INFO - warning: no files found matching '*.txt' 03:03:42 INFO - no previously-included directories found matching 'build' 03:03:42 INFO - no previously-included directories found matching 'dist' 03:03:42 INFO - no previously-included directories found matching '.git*' 03:03:42 INFO - Successfully installed jsonschema functools32 03:03:42 INFO - Cleaning up... 03:03:43 INFO - Return code: 0 03:03:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03:43 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 03:03:43 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 03:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:43 INFO - 'HOME': '/Users/cltbld', 03:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:43 INFO - 'LOGNAME': 'cltbld', 03:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:43 INFO - 'MOZ_NO_REMOTE': '1', 03:03:43 INFO - 'NO_EM_RESTART': '1', 03:03:43 INFO - 'PAGER': '/bin/cat', 03:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:43 INFO - 'PWD': '/builds/slave/test', 03:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:43 INFO - 'SHELL': '/bin/bash', 03:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:43 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:43 INFO - 'USER': 'cltbld', 03:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:43 INFO - 'XPC_FLAGS': '0x0', 03:03:43 INFO - 'XPC_SERVICE_NAME': '0', 03:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:03:43 INFO - Cleaning up... 03:03:43 INFO - Return code: 0 03:03:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:43 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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03:43 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 03:03:43 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 03:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:43 INFO - 'HOME': '/Users/cltbld', 03:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:43 INFO - 'LOGNAME': 'cltbld', 03:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:43 INFO - 'MOZ_NO_REMOTE': '1', 03:03:43 INFO - 'NO_EM_RESTART': '1', 03:03:43 INFO - 'PAGER': '/bin/cat', 03:03:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:43 INFO - 'PWD': '/builds/slave/test', 03:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:43 INFO - 'SHELL': '/bin/bash', 03:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:43 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:43 INFO - 'USER': 'cltbld', 03:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:43 INFO - 'XPC_FLAGS': '0x0', 03:03:43 INFO - 'XPC_SERVICE_NAME': '0', 03:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:03:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:03:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:47 INFO - Downloading docopt-0.6.1.tar.gz 03:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:03:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:03:47 INFO - Running setup.py install for blobuploader 03:03:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:03:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:03:47 INFO - Running setup.py install for requests 03:03:48 INFO - Running setup.py install for docopt 03:03:48 INFO - Successfully installed blobuploader requests docopt 03:03:48 INFO - Cleaning up... 03:03:48 INFO - Return code: 0 03:03:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:48 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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03:48 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 03:03:48 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 03:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:48 INFO - 'HOME': '/Users/cltbld', 03:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:48 INFO - 'LOGNAME': 'cltbld', 03:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:48 INFO - 'MOZ_NO_REMOTE': '1', 03:03:48 INFO - 'NO_EM_RESTART': '1', 03:03:48 INFO - 'PAGER': '/bin/cat', 03:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:48 INFO - 'PWD': '/builds/slave/test', 03:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:48 INFO - 'SHELL': '/bin/bash', 03:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:48 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:48 INFO - 'USER': 'cltbld', 03:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:48 INFO - 'XPC_FLAGS': '0x0', 03:03:48 INFO - 'XPC_SERVICE_NAME': '0', 03:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:48 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ZN0m7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:48 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-mJsE4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:48 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-hIbqPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:48 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-KHJ1QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CO4AXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-R4nr14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-i0mysE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-K8vTJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-4yu6h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GSR7tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5eY_Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-o3XHpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-w72t3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:49 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-boJBrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:50 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3vo8JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:50 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-9NQjJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:50 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-4TFxwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:03:50 INFO - Running setup.py install for manifestparser 03:03:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:03:50 INFO - Running setup.py install for mozcrash 03:03:50 INFO - Running setup.py install for mozdebug 03:03:50 INFO - Running setup.py install for mozdevice 03:03:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:03:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:03:50 INFO - Running setup.py install for mozfile 03:03:51 INFO - Running setup.py install for mozhttpd 03:03:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Running setup.py install for mozinfo 03:03:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Running setup.py install for mozInstall 03:03:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Running setup.py install for mozleak 03:03:51 INFO - Running setup.py install for mozlog 03:03:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:03:51 INFO - Running setup.py install for moznetwork 03:03:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:03:52 INFO - Running setup.py install for mozprocess 03:03:52 INFO - Running setup.py install for mozprofile 03:03:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:03:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:03:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:03:52 INFO - Running setup.py install for mozrunner 03:03:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:03:52 INFO - Running setup.py install for mozscreenshot 03:03:52 INFO - Running setup.py install for moztest 03:03:52 INFO - Running setup.py install for mozversion 03:03:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:03:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:03:52 INFO - Cleaning up... 03:03:52 INFO - Return code: 0 03:03:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03: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 03:03: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 03:03:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:52 INFO - 'HOME': '/Users/cltbld', 03:03:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:52 INFO - 'LOGNAME': 'cltbld', 03:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:52 INFO - 'MOZ_NO_REMOTE': '1', 03:03:52 INFO - 'NO_EM_RESTART': '1', 03:03:52 INFO - 'PAGER': '/bin/cat', 03:03:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:52 INFO - 'PWD': '/builds/slave/test', 03:03:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:52 INFO - 'SHELL': '/bin/bash', 03:03:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:52 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:52 INFO - 'USER': 'cltbld', 03:03:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:52 INFO - 'XPC_FLAGS': '0x0', 03:03:52 INFO - 'XPC_SERVICE_NAME': '0', 03:03:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-cU9kGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:53 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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-9DzgCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03: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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-funfcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03: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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-5Yzzd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03: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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-BNEuqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03: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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XIrWR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03: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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TMQuJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03: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)) 03:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:53 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8okoWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:54 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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GM6FYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:54 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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rgnF6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:54 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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-9Y27cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03: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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vh4mun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03: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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-SorUHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03: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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-WAeDwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03: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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-T6o4IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03: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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-hUzJm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03: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)) 03:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:54 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Gs6Lu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 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)) 03:03:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:55 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 03:03:57 INFO - Downloading blessings-1.6.tar.gz 03:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:03:57 INFO - Installing collected packages: blessings 03:03:57 INFO - Running setup.py install for blessings 03:03:57 INFO - Successfully installed blessings 03:03:57 INFO - Cleaning up... 03:03:57 INFO - Return code: 0 03:03:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:03:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:58 INFO - Reading from file tmpfile_stdout 03:03:58 INFO - Current package versions: 03:03:58 INFO - blessings == 1.6 03:03:58 INFO - blobuploader == 1.2.4 03:03:58 INFO - docopt == 0.6.1 03:03:58 INFO - functools32 == 3.2.3-2 03:03:58 INFO - jsonschema == 2.5.1 03:03:58 INFO - manifestparser == 1.1 03:03:58 INFO - mozInstall == 1.12 03:03:58 INFO - mozcrash == 1.0 03:03:58 INFO - mozdebug == 0.1 03:03:58 INFO - mozdevice == 0.49 03:03:58 INFO - mozfile == 1.2 03:03:58 INFO - mozhttpd == 0.7 03:03:58 INFO - mozinfo == 0.9 03:03:58 INFO - mozleak == 0.1 03:03:58 INFO - mozlog == 3.4 03:03:58 INFO - moznetwork == 0.27 03:03:58 INFO - mozprocess == 0.25 03:03:58 INFO - mozprofile == 0.28 03:03:58 INFO - mozrunner == 6.13 03:03:58 INFO - mozscreenshot == 0.1 03:03:58 INFO - mozsystemmonitor == 0.3 03:03:58 INFO - moztest == 0.8 03:03:58 INFO - mozversion == 1.4 03:03:58 INFO - psutil == 3.1.1 03:03:58 INFO - requests == 1.2.3 03:03:58 INFO - wsgiref == 0.1.2 03:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:58 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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03:58 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 03:03:58 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 03:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:58 INFO - 'HOME': '/Users/cltbld', 03:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:58 INFO - 'LOGNAME': 'cltbld', 03:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:58 INFO - 'MOZ_NO_REMOTE': '1', 03:03:58 INFO - 'NO_EM_RESTART': '1', 03:03:58 INFO - 'PAGER': '/bin/cat', 03:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:58 INFO - 'PWD': '/builds/slave/test', 03:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:58 INFO - 'SHELL': '/bin/bash', 03:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:58 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:58 INFO - 'USER': 'cltbld', 03:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:58 INFO - 'XPC_FLAGS': '0x0', 03:03:58 INFO - 'XPC_SERVICE_NAME': '0', 03:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03: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)) 03:03:58 INFO - Cleaning up... 03:03:58 INFO - Return code: 0 03:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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 0x109adbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ade768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba2b5b8de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, '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.T1EFubY78C/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.bULyUj2tJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 03:03: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 03:03: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 03:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:58 INFO - 'HOME': '/Users/cltbld', 03:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:58 INFO - 'LOGNAME': 'cltbld', 03:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:58 INFO - 'MOZ_NO_REMOTE': '1', 03:03:58 INFO - 'NO_EM_RESTART': '1', 03:03:58 INFO - 'PAGER': '/bin/cat', 03:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:58 INFO - 'PWD': '/builds/slave/test', 03:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:58 INFO - 'SHELL': '/bin/bash', 03:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:03:58 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:58 INFO - 'USER': 'cltbld', 03:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:58 INFO - 'XPC_FLAGS': '0x0', 03:03:58 INFO - 'XPC_SERVICE_NAME': '0', 03:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:03:58 INFO - Cleaning up... 03:03:58 INFO - Return code: 0 03:03:58 INFO - Running post-action listener: _resource_record_post_action 03:03:58 INFO - Running post-action listener: _start_resource_monitoring 03:03:58 INFO - Starting resource monitoring. 03:03:58 INFO - [mozharness: 2017-03-14 10:03:58.833110Z] Finished create-virtualenv step (success) 03:03:58 INFO - [mozharness: 2017-03-14 10:03:58.834041Z] Running install step. 03:03:58 INFO - Running pre-action listener: _resource_record_pre_action 03:03:58 INFO - Running main action method: install 03:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:59 INFO - Reading from file tmpfile_stdout 03:03:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:03:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:03:59 INFO - Reading from file tmpfile_stdout 03:03:59 INFO - Output received: 03:03:59 INFO - Usage: mozinstall [options] installer 03:03:59 INFO - Options: 03:03:59 INFO - -h, --help show this help message and exit 03:03:59 INFO - -d DEST, --destination=DEST 03:03:59 INFO - Directory to install application into. [default: 03:03:59 INFO - "/builds/slave/test"] 03:03:59 INFO - --app=APP Application being installed. [default: firefox] 03:03:59 INFO - mkdir: /builds/slave/test/build/application 03:03:59 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'] 03:03:59 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 03:04:19 INFO - Reading from file tmpfile_stdout 03:04:19 INFO - Output received: 03:04:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:04:19 INFO - Running post-action listener: _resource_record_post_action 03:04:19 INFO - [mozharness: 2017-03-14 10:04:19.196509Z] Finished install step (success) 03:04:19 INFO - [mozharness: 2017-03-14 10:04:19.196653Z] Running run-tests step. 03:04:19 INFO - Running pre-action listener: _resource_record_pre_action 03:04:19 INFO - Running main action method: run_tests 03:04:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:19 INFO - 2017-03-14 03:04:19.211 screenresolution[1628:7613] starting screenresolution argv=screenresolution get 03:04:19 INFO - 2017-03-14 03:04:19.213 screenresolution[1628:7613] Display 0: 1600x1200x32@60 03:04:19 INFO - 2017-03-14 03:04:19.219 screenresolution[1629:7616] starting screenresolution argv=screenresolution list 03:04:19 INFO - Available Modes on Display 0 03:04:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:19 INFO - Intel Iris: 03:04:19 INFO - Chipset Model: Intel Iris 03:04:19 INFO - Type: GPU 03:04:19 INFO - Bus: Built-In 03:04:19 INFO - VRAM (Dynamic, Max): 1536 MB 03:04:19 INFO - Vendor: Intel (0x8086) 03:04:19 INFO - Device ID: 0x0a2e 03:04:19 INFO - Revision ID: 0x0009 03:04:19 INFO - Displays: 03:04:19 INFO - Display: 03:04:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:19 INFO - Display Serial Number: 1600x1200 60 03:04:19 INFO - Main Display: Yes 03:04:19 INFO - Mirror: Off 03:04:19 INFO - Online: Yes 03:04:19 INFO - Rotation: Supported 03:04:19 INFO - Return code: 0 03:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:19 INFO - Python 2.7.3 03:04:19 INFO - Return code: 0 03:04:19 INFO - grabbing minidump binary from tooltool 03:04: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')]} 03:04: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 0x1098b9d30>, '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 0x1097e0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098aebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04: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 03:04: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 03:04: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 03:04:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:19 INFO - Return code: 0 03:04:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:04:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:19 INFO - ENV: RUST_BACKTRACE is now 1 03:04:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:04:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04: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/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 03:04: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/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 03:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T1EFubY78C/Render', 03:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:19 INFO - 'HOME': '/Users/cltbld', 03:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:19 INFO - 'LOGNAME': 'cltbld', 03:04:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:19 INFO - 'MOZ_NO_REMOTE': '1', 03:04:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:19 INFO - 'NO_EM_RESTART': '1', 03:04:19 INFO - 'PAGER': '/bin/cat', 03:04:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:19 INFO - 'PWD': '/builds/slave/test', 03:04:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:19 INFO - 'RUST_BACKTRACE': '1', 03:04:19 INFO - 'SHELL': '/bin/bash', 03:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bULyUj2tJN/Listeners', 03:04:19 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 03:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:19 INFO - 'USER': 'cltbld', 03:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:19 INFO - 'XPC_FLAGS': '0x0', 03:04:19 INFO - 'XPC_SERVICE_NAME': '0', 03:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04: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/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 03:04:19 INFO - mozversion application_buildid: 20170314012636 03:04:19 INFO - mozversion application_changeset: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 03:04:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:04:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:19 INFO - mozversion application_name: Firefox 03:04:19 INFO - mozversion application_remotingname: firefox-dev 03:04:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:19 INFO - mozversion application_vendor: Mozilla 03:04:19 INFO - mozversion application_version: 54.0a2 03:04:19 INFO - mozversion platform_buildid: 20170314012636 03:04:19 INFO - mozversion platform_changeset: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 03:04:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:19 INFO - mozversion platform_version: 54.0a2 03:04:19 INFO - using testdate: 1489485859 03:04:19 INFO - actual date: 1489485859 03:04:19 INFO - starting webserver on 'localhost:49240' 03:04:19 INFO - SUITE-START | Running 2 tests 03:04:19 INFO - TEST-START | dromaeo_css 03:04:19 INFO - operating with platform_type : mac_ 03:04:19 INFO - Initialising browser for dromaeo_css test... 03:04:19 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpqRvEBV/profile http://localhost:49240/getInfo.html) 03:04:22 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 03:04:22 INFO - PROCESS | 1639 | colorDepth:24 03:04:22 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 03:04:22 INFO - PROCESS | 1639 | __metrics 03:04:22 INFO - PROCESS | 1639 | 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" 03:04:22 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:04:23 INFO - TEST-INFO | 1639: exit 0 03:04:23 INFO - Browser initialized. 03:04:23 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:23 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpqRvEBV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:35 INFO - PROCESS | 1641 | RSS: Main: 214241280 03:04:35 INFO - PROCESS | 1641 | 03:07:38 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 03:07:42 INFO - PROCESS | 1641 | RSS: Main: 500523008 03:07:42 INFO - PROCESS | 1641 | 03:09:25 INFO - PROCESS | 1641 | ************************* 03:09:25 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 03:09:25 INFO - PROCESS | 1641 | 03:09:25 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:09:25 INFO - PROCESS | 1641 | Full stack: 03:09:25 INFO - PROCESS | 1641 | ************************* 03:10:45 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 03:10:46 INFO - PROCESS | 1641 | RSS: Main: 352935936 03:10:46 INFO - PROCESS | 1641 | 03:13:48 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 03:13:49 INFO - PROCESS | 1641 | RSS: Main: 333119488 03:13:49 INFO - PROCESS | 1641 | 03:16:51 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 03:16:52 INFO - PROCESS | 1641 | RSS: Main: 340520960 03:16:52 INFO - PROCESS | 1641 | 03:19:55 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 03:19:56 INFO - PROCESS | 1641 | RSS: Main: 323887104 03:19:56 INFO - PROCESS | 1641 | 03:22:59 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 03:23:00 INFO - PROCESS | 1641 | RSS: Main: 402669568 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | __start_tp_report 03:23:00 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 03:23:00 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 03:23:00 INFO - PROCESS | 1641 | |i|pagename|runs| 03:23:00 INFO - PROCESS | 1641 | |0;dojo.html;3043.8129129639433;3182.4589819730645;3393.4061539230634;3411.4030044742162;3447.3450044491547;5816.709164541772;5882.205902203202;5896.823095307137;5907.379725128864;5910.615809972349;5875.970620146893;5938.990371636822;5947;5955.255593050869;5961.761529538824;5295.682259064449;5299.152135658286;5343.7328133593355;5420.051490989081;5423.810166644168;5233.450487698794;5248.0815857225025;5295.179247216687;5434.565234781208;5454.645448045884;5301;5335.546478549328;5336.67979921204;5337.14605663094;5338.67967921924;4401.713888597231;5306.124489459235;5323.387810401776;5331.466853314657;5334.67991920486;4363;5163.173892177271;5277.8416647500635;5290.68255904647;5308.124159513675;5895.056790913433;5905.2323197984415;5909.911351329733;5912.674802885839;5916.26046744157;6245.094461303085;6272.341404152589;6280.87438251237;6283.371662833726;6304.401081897213;6316.62100273985;6318.589291696025;6318.842028949267;6321.494280457552;6384.265809431882;4917.237828136609;6066.332703402622;6066.363031881633;6072.271327440735;6073.635581865102;6262.624242545462;6551.475881929434;6595.307492713244;6610.206775186912;6616.702248398786;6216.720247588869;6225.750969961241;6238.189035425366;6238.781642642486;6249.25008998923;6139.075791860876;6254.718537665725;6312.084747711556;6338.397852204033;6342.5560210785725;6289.8742025159245;6325.810225693236;6327.335629758901;6329.683515824282;6344.8413789654705;6314.052892066226;6316.778912738032;6322.652254126067;6323.652199129;6334.9366506334345;4838.685485443435;5028.396592408934;5029.874253143701;5037.19404895215;5101.744912754348;4487.887802804956;4497.055618320124;4504.301833215857;4512.390827238347;4515.616172625364;5799.449052340021;5846.327672317653;5846.970765146147;5850.970745146247;5872.853178670567;6139.969300153471;6306.369363063657;6328.778492752732;6338.176037115146;6358.237011558643;6015.879682406327;6017.007193812972;6023.45788879003;6027.427394397525;6065.363136870653;5640.153976903415;5641.294838145232;5644.238027866268;5653.491185793216;5673.886522269531;6315.621062736251;6383.425491705769;6664.067030615718;6679.231888332807;6683.231428385798;6309.432151106423;6328.240611126695;6337.081123237197;6337.8732425352155;6339.873202536016;6443.097966284818;6454.741810327534;6548.377904099103;6581.14445122131;6678.49911256648;6266.561340706289;6306.117143599991;6334.588251763621;6334.588251763805;6336.17629708135;6389.393007664265;6392.584482008655;6398.584092034003;6412.487001039999;6418.037294405876;6125.816225513242;6139.539534534839;6145.187169784835;6170.845728856814;6290.811275661737;6154.5384096192065;6184.196054512884;6204.5967012144065;6215.968920155551;6216.285127210429;5289.624697578581;5816.854578635399;6112.449879510866;6136.907946380718;6141.355157708376;6215.9378406215355;6239.407256310643;6239.594426362272;6300;6314.368563143649;5935.940640593539;5952.315483719428;6061.545384096298;6154.1999540059505;6242.65665388408 03:23:00 INFO - PROCESS | 1641 | |1;ext.html;787.5353541410567;811.3995643224014;871.0114020586636;892.6607889002174;893.6336102198092;27243.31891702706;39112.804435977814;39383;39782.60217397825;39917.401238981365;40153.7992310038;40413.59586404135;40455.59544404555;40492.59507404925;40551.59448405515;7252.6011069391425;8994.460332380046;9109;9148.542572871329;9151.908480915172;7299.19708832028;10747;10924.28992115514;11111.611093611726;11122;10911.181661375389;10922.781544369147;10939.234253602252;10962.506687199055;10985.505652245669;7106.538075025107;10895.673129806119;10925.453727313603;10925.890741092606;10942.890571094267;7199.820004499877;7241.637918104074;7242.601656908868;7254.5647261164495;10556.894431055745;37912.81043594792;38117;38128.237435251416;38128.42807357892;38187;3845.61543845616;3889.68882489403;3893;3929.862454814068;3950.6839452843706;26195;26333.94664213429;27138.728612713818;27406.45187096267;27910.302242443897;3040.361524079946;3121.641011283709;3131.984340078285;3158.921026974321;3188.21888637283;262567.6871615649;332418;332688.33655831567;332757;332933;39994.0001499959;41467.58532414637;50674.746626266635;50742.23886641629;50749;43354.56645433505;52364.0726945473;53242.73378633082;54968;55782.44217557772;11231;13535.59393218205;13607.795883061763;13640.86359136396;13646.317684115755;11545.24955877882;11588.94205528984;11590.304581725124;11618.88381116195;11621.012213961907;11757.941210293893;11775.705607359712;11776.11679124069;11817.054635629129;11844.76310473803;5029.949700502948;5201.245819356172;5486.231927530149;5575.526080283222;5587.357453892773;1058.259163675749;1077;1089.9618513352152;1138.3795831271977;1141.697450175704;22006.779932200792;25591.61612575813;26533.46933061328;26591.596371160304;26749.465010700067;1020.6784862768204;1143.656902929118;1166.1720178673238;1196.8922796948316;1201.537408097871;13337.599872003855;13697.726045479034;13952.953528485405;13958;14037.227952462508;415360;415442;416393;416914;417464;53860.92278154415;53878;53905.46094539083;53928.46071539313;53986.46013539893;1389.8540653231264;1445.3206992713617;1447.471672839406;1449.2029383839058;1452.0271418149864;25242.36894077663;26013.349666258495;26224.606630900933;26295.4740905177;26394.472110557297;43330;43413.34879976866;43474.56525434705;43485.3477197836;43615.781921090194;423007;423926;424246;424634;424763;32120.35759284848;33042;33045.67817287282;33104.1723956903;33155.67377304881;39624.57591441542;41599.37600936049;41812.98244210714;42662.786686067615;42709.35935961025;34277;34366;34366.656333436345;34399.656003439646;35553.466697999036;34227.4865877017;34314.656853431145;35357.292854143285;35457;35499.290014199054;34188.82905585456;34519.4822077674;35117.473237900944;35196.648033519334;35215.47176792401;29155;30640.693593063785;30875.073747787603;30884.382312354075;31198.064058078293;18235.908820455814;18354.541136471697;20151.790892546494;23779;23864.284071477883 03:23:00 INFO - PROCESS | 1641 | |2;jquery.html;385.7454080306998;405.2057966385884;409.8299205829579;425.58505457179257;448.90797386535763;13261.535846245384;20983.265585704503;22100.22649207278;22379.55240895181;22456.8877155614;20454.181832726674;20901.895490522526;21042.579148417022;21325.68011479829;21856.344309670694;4924.630652701044;6209;6345.540525679096;6468.611883287018;6520.804375868708;5260.316158899338;6446.838829029289;6449.742010319582;6456.386643268882;6456.677166141698;6343.365663433643;6350.491960643138;6435.871282574346;6437.903431448532;6477.319881412454;6272.623642581414;6325.620462772225;6406.0711196876655;6413.134226879405;6441.4524765395;6180.165677633507;6209.813705588839;6243.531735119839;6254.562180647356;6266.87466250677;24476;25483.872580636977;25657;25894.741052589423;25938.610920836203;3096.7987080839675;3313.6355000949875;3337;3342.715869151125;3369.4608862582113;15751.448699295584;15758.921205394014;15790.763138552931;15797.68404631901;15852.524424267174;1908.9427317180507;2013.6677448221026;2076.584683063378;2101.857722704551;2120.120150137691;152951.2352438242;156956;157600.66880312125;159627;163630;14782.890311651514;18963.81036189648;19972.600547988957;20121.698174527395;20175.99120043992;24328.513429731305;28940.855295723388;30492;31551.84224078911;31920.361592768015;8408.495490270481;8799.736007919773;8916.286697064219;9470.431774093577;9822.607095716092;7199.9280007200305;7387.224341444071;7393.297636724503;8237.670493180325;8252.669893204205;9206.953965230265;9211.355205135711;9332.860007099898;9414.529273536296;9439.24486041115;3925.9018524537114;3946.5264168299414;3972.900677483086;3989.3218152913496;3991.720579559461;774.3766268154077;879;886.1050339157497;886.1714297132073;920.9539523023822;21310.893445532674;21876.45308867291;21877.890610547165;21923.890380547997;22195.889020554794;767.4896194030907;896.5203616065373;916.7891384981492;919.1084647891535;927.0868194828089;8993.595288212045;10770.084542813793;11256.774864502828;11405.315681059163;11452;380658;533222;774181;784218;803800;129471;151923.24038379738;154428.45571544365;155131;160025.19987400222;1159.5999380213814;1198.3469009389903;1205.52984336109;1244.975100497985;1251.5181655062866;19401.70897436568;19694.704579431032;20188.788672679686;20200.19199232073;20207.898960505103;33912;50771.74614126905;64832.67583662052;65940.34059659342;66525;76816;87008.69486957828;87796;88949;89731.78352705912;11387.975082242638;11402.885971140182;11577.6526704199;11675.649730508097;11828.881711182778;10128.645497407555;12288.938555307166;12322.445489953154;12368.690782730504;12665.683357916127;5892;7687.961560192163;9966.651167209113;10983.450827458435;11391.031762300297;10696.62561810333;10845.240833141605;10850.240483166102;11145.777084458428;11168.944155279172;8114.878276825734;11075.224734268524;11085.612003579836;11331.603393881174;11388.601398950997;11428.25716328436;11503.48234329474;11582.6525204244;11786.646400607653;11832.112591555495;10790.136789057013;10838.945805270923;11102.2783519071;11203.383813890314;11344.829827552758 03:23:00 INFO - PROCESS | 1641 | |3;mootools.html;1524.382625036859;1537.123839411536;1561.3910574875802;1576.6294920693638;1579.6366835627805;10523.684289471308;11084.168687348461;11089.05743011845;11093.889061109387;11098.944505277472;10466.633667821608;10847.403392813392;11016.944915275433;11022.118230541557;11023.118150547956;2364.538914911597;2396.364963284731;2400.7719266669637;2402.615581506959;2402.95194096118;2330.976690233101;2349.5183487385043;2357.3045951444365;2361.728401233854;2364.408897775556;2342.6954495915593;2354.3996280948336;2359.539889721505;2364.8344615876895;2366.0299277296313;2299.3561802695103;2321.257197696738;2326.139328448468;2328.7089113860766;2328.953420931589;2277.0436416705024;2333.8599684018845;2338.4153961509624;2338.4621537046573;2345.566070277004;10704.732381690443;10772.461376931122;10773.353598784099;10781.299215550964;10789.676309710721;5300.496452836975;5681.034224181858;5701.230333904911;5716.771329146829;5727.198192253088;2972;3364.1253274148653;3414.334204830059;3428.2629234714404;3586.910327241814;1014.7818219082859;1137.1585027079984;1144.6279959013355;1183.923045002072;1209.6008317255285;13714.725705485935;14076.507322243775;14088.084274522022;15497.225138743017;15589;4101.200265948111;4181.372794080912;4207.221663992172;4224.155168966219;4455.1535208310315;11524.193306468635;11525.250858694159;11545.076393888468;11559.190856639954;11569.942150289364;5607.186957891083;5615.241942337814;5619.831405057855;5647.774089036475;5648.068068768607;4907.411110666742;5091.210862316347;5155.871103222449;5161.690298582097;5171.482851714798;3572.1248294167576;3666.175110600147;3701.3152566775234;3740.7007439404783;3743.8502459901842;953.0897992417225;955.2232846904751;955.9235261179089;972.0522490571777;972.6060945317158;757.6514803190483;773.1070613441484;789.2305002622512;796.243568609823;803.8231589050399;6429.7749578764515;6578.901316480256;6626.105475760807;6641.236257830315;6709.932900671029;961.6057416459358;963.1668606655332;967.9564419601135;973.4159504297506;982.5431174503747;3488.965110348864;4336.9132617348105;4388.363687265329;4395.846145384896;4512.842050528216;13609.183448993092;13834.93082534581;13866.722665546633;13912.58262252134;13937.372818223204;13673.86326136726;13803.723925521634;13872.028957973047;13876.444942202199;13880.958928080434;9904.900950990543;9985.1512621428;10049.748756281006;10312;10332.896671033193;5701.657900525815;6620.184800230729;6638.800835974928;6671.532992690465;6855.040294358694;11940.880591193976;12116.939415302868;12151.574694885636;12312;12358.2585044894;10239.436830974368;11200.775984480102;12469.5012199511;12482.375881206084;12553.932915702268;8937.508437036025;9226.261899048195;9386.812263754824;9393.154616084585;9394.295427842802;8457.788555286166;10177.745556360855;10199.337043092175;10291.22815788804;10377.429241391494;9075.183233509017;9120.787188271703;9178.219851312713;9195.448273103635;9358.766030849283;9165;9291.48896810682;9324.95337523308;9343;9429.669961551313;7707.152213256425;7854.332381747616;7937.722179723682;7942.324902383362;7949.761507154794;5557.416471270459;5746.856328591652;5778.104393818965;5897.764089436546;5979.402059793986;5879.353271140086;5956.76172953077;6023.6385816851125;6028.909566356596;6211 03:23:00 INFO - PROCESS | 1641 | |4;prototype.html;368.13488302489156;377.8545260074871;384.6134634692134;384.66341950793054;387.6162599026963;4574.839880604171;4785.641076919228;4998.300577803546;5074.340335756351;5082.745862706864;3837.5394952605725;4165.708400411965;4345.588712860405;4421.6904816662845;4851.490593487686;3767.71897554832;4174.457320548325;4265.893352666177;4286.185624731291;4289.498675463594;3545.6631619996188;4097.221527909703;4317.460317460317;4329.805158767863;4333.349997500369;3745.4381842723537;3820.961790382102;4194.832206711728;4224.683148763839;4234.597713217239;4250.659947204232;4274.358846173068;4276.48682158143;4291.270484017725;4299.570042995707;3250.4961730931745;3688.7417880748358;4060.593940605945;4090.6931980101613;4165;4729.162502498508;4828.73441960692;4835.848047618811;4838.854834354975;4910.607151427877;4309.4397728295435;4357.978210108961;4957.752112394366;4959.380077490314;4978.90042199154;4359.564043595647;5317.46825317469;5321.115585622479;5328.813491527817;5336.479103455536;3852.036990752312;4025.81238534633;4182.477190351206;4400.339949007643;4456.818942980113;4868.95131048692;4916.410030796256;5111.386633603955;5576.302962129734;5598.832035038955;3791.0855018216175;4346.47842258931;4566.885827854264;4695.107929493385;4752.714837109785;4165.958510372407;4213.431186789744;4760.190767569521;4790.856274311776;4799.520047995173;4949.158643030693;4969.378827646544;4984.27727979441;4986.950130498649;4998.800047998039;4126.122614210527;5100.240417056184;5253.1857562077175;5348.930213957224;5376.973115134478;1480.8227459169987;1537.8615924566618;1547.9705995513084;1641.5075477356745;1657.32049859557;1072.9946350268199;1202.5129822421934;1218.2873019283818;1256.8428946381703;1348.420179322881;4060.5127384713433;4603.723776573416;5003.122580000529;5005.74971251436;5033.899322013539;4601.469191944418;4705.0828486338005;5105.387353517527;5259.789608415621;5450.672959622435;4168.749875007509;4615.561521655437;4639.072185562901;4999;4999.75001249936;2818.788590855694;2828.7454129128064;2831.6743574488787;2848.61543691599;2862.3416614178855;5680.318361796611;5681.471745073485;5697.430256974352;5706.686132262683;5731.369549349568;4495.483019452739;5171.146760784503;5397.652021370638;5550.30810057122;5636.464535869086;5071.410373611887;5592.888142237214;5620.662760234399;5699.800506982236;5708.600397972102;4488.865334039984;4630.953690463052;4915.754212289443;5450.482204190595;5489.58828087887;4505.684602077823;5042.520960508746;5098.818968445838;5264.605154613496;5370.758315875873;4870.634702397405;4942.950570494393;5600.439956004367;5645.350784659817;5689;4385.254506733927;4719.929201061918;4720.598749106364;4749.382580264543;4783.091212669721;4682.648801339845;5274.498922602346;5295.7616907240035;5431.402545719889;5506.284183056177;4417.469903611587;4632.4712844761825;4662.573008838433;5200.843974680765;5214.791408343775;4560.817567297271;4735.863392785775;5170.37955445349;5220.347456567929;5340.359156901041;4524.502304746409;4881.975590122027;5004.449510553909;5068.746562671926;5250.2674117540355;4243.511996120362;4390.209762242699;4570.6800523963;5308.654937429054;5342.958123165945;4144.52337981136;4912.582430493448;5194.272801807674;5271.68369897792;5273.683578985273 03:23:00 INFO - PROCESS | 1641 | |5;yui.html;716.323074694414;735.6358602491764;775.7478819383698;830.2278880641004;844.2612713875361;13427.328633568331;15087.396504139835;15238.238088095579;15933.601659958507;15938.601534961617;14539;14565.980381373309;14569.344379502947;14648.34082466289;14659.706805863876;890.5591732092607;908.8318661047695;916.331078312832;935.9906400935971;946.6260826973341;900.8513595256775;912.370464379576;914.9588268527899;916.3677062826662;934.8410770169088;967.0184762466102;967.7532229281559;968.5109019944917;970.112347202309;970.5438443931376;960.7982323712029;961.5721004153155;962.841131213349;963.6097380560814;965.0879918477042;716.0941409117471;716.1442076718324;717.2289788477408;717.6878058044715;718.0199028326349;15577.688446231125;15888.60278493047;15938.12340321282;16021.958572692738;16270.674586508203;12484.937575312157;13928.58214253574;14085.295735213302;14241;14258.857411425857;11816.784992613852;11884.049276057895;11892.219917528444;11913.166078374517;12094.697632559168;3581.606023337431;3642.981785091084;3731.869384571527;3760.6051364606597;3876.205377897524;101343;110135;110612.4469377656;112173;115090;10475.47622618866;10554.2084343673;10895.782084358269;11148.331100134017;11220.214584979136;19887.900560497106;22180;22262.22082227114;22365.329040128498;22562.54874902493;7815.996356363524;7825.0218722659665;7912.762617121495;7928.84142317162;8005.479643823133;4207.684423668237;4301.591348821857;4304.634106101016;4378.496472905656;4439.156560253606;3483.860645574199;3565.2691198304287;3590.8025058621506;3591.102224443889;3591.2099338145567;641.0512441586478;653.8953767397194;660.1813750948885;660.5838321857199;662.5726406467898;653.9574927629689;669.8693754717881;678.8031470873391;709.9183593886769;711.5837235217456;7758.534487930629;10214.693559193236;10241.795164096677;10374.27380083402;10409.323393979366;669.1501792723215;680.7957612716166;709.9964500177466;720.6000669628406;724.3589423360364;4617.8152873884665;4909.926351104737;4953.851384458472;4956.529129732669;4959.677620954626;103392;103999;104636.67543271898;104886;106098;92493.53753231191;93774.12451750926;94263.0573694268;95053.5247323759;96432;80194;80950.19049809544;82868.91300360313;83958.58020709979;85005.14994850096;9220.907790922005;9325.207357374427;9509.61961521559;9547.904520954702;9562.856557151787;50723.23915141202;50893.74553127211;50993;52090.73954630203;52219.73890130525;65322;65409;66722.66554668976;66841;67984;11016.228863979444;11326.490307935997;11331.716707082389;11349.37578433161;11990.580329688419;12293.692657683629;12317.692057698629;12361.320127393079;12433.06751993586;13093.279869607262;11219;11349.829752553553;11478.196526243082;11689.766204675689;12060.155789094679;11712.355820429959;11944.343061131374;12051.638450846489;12077.51689932393;12101.152919295564;11373.658790236306;11790.174687771774;11914.582989595323;11916.404179791149;12394.566190183301;9341.392809467363;10034.849477257992;10059.49702514886;10219.131373833308;10618.938106189627;9680.634743431372;9766.658166964122;9792.363496372998;9865;9961.356805495909 03:23:00 INFO - PROCESS | 1641 | __end_tp_report 03:23:00 INFO - PROCESS | 1641 | __start_cc_report 03:23:00 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,3414 03:23:00 INFO - PROCESS | 1641 | __end_cc_report 03:23:00 INFO - PROCESS | 1641 | __startTimestamp1489486980083__endTimestamp 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | ------- Summary: start ------- 03:23:00 INFO - PROCESS | 1641 | Number of tests: 6 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5862.35 Median:6136.91 stddev:692.57 (11.3%) stddev-sans-first:658.45 03:23:00 INFO - PROCESS | 1641 | Values: 3043.8 3182.5 3393.4 3411.4 3447.3 5816.7 5882.2 5896.8 5907.4 5910.6 5876.0 5939.0 5947.0 5955.3 5961.8 5295.7 5299.2 5343.7 5420.1 5423.8 5233.5 5248.1 5295.2 5434.6 5454.6 5301.0 5335.5 5336.7 5337.1 5338.7 4401.7 5306.1 5323.4 5331.5 5334.7 4363.0 5163.2 5277.8 5290.7 5308.1 5895.1 5905.2 5909.9 5912.7 5916.3 6245.1 6272.3 6280.9 6283.4 6304.4 6316.6 6318.6 6318.8 6321.5 6384.3 4917.2 6066.3 6066.4 6072.3 6073.6 6262.6 6551.5 6595.3 6610.2 6616.7 6216.7 6225.8 6238.2 6238.8 6249.3 6139.1 6254.7 6312.1 6338.4 6342.6 6289.9 6325.8 6327.3 6329.7 6344.8 6314.1 6316.8 6322.7 6323.7 6334.9 4838.7 5028.4 5029.9 5037.2 5101.7 4487.9 4497.1 4504.3 4512.4 4515.6 5799.4 5846.3 5847.0 5851.0 5872.9 6140.0 6306.4 6328.8 6338.2 6358.2 6015.9 6017.0 6023.5 6027.4 6065.4 5640.2 5641.3 5644.2 5653.5 5673.9 6315.6 6383.4 6664.1 6679.2 6683.2 6309.4 6328.2 6337.1 6337.9 6339.9 6443.1 6454.7 6548.4 6581.1 6678.5 6266.6 6306.1 6334.6 6334.6 6336.2 6389.4 6392.6 6398.6 6412.5 6418.0 6125.8 6139.5 6145.2 6170.8 6290.8 6154.5 6184.2 6204.6 6216.0 6216.3 5289.6 5816.9 6112.4 6136.9 6141.4 6215.9 6239.4 6239.6 6300.0 6314.4 5935.9 5952.3 6061.5 6154.2 6242.7 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:52636.50 Median:34208.16 stddev:103170.04 (301.6%) stddev-sans-first:103386.02 03:23:00 INFO - PROCESS | 1641 | Values: 787.5 811.4 871.0 892.7 893.6 27243.3 39112.8 39383.0 39782.6 39917.4 40153.8 40413.6 40455.6 40492.6 40551.6 7252.6 8994.5 9109.0 9148.5 9151.9 7299.2 10747.0 10924.3 11111.6 11122.0 10911.2 10922.8 10939.2 10962.5 10985.5 7106.5 10895.7 10925.5 10925.9 10942.9 7199.8 7241.6 7242.6 7254.6 10556.9 37912.8 38117.0 38128.2 38128.4 38187.0 3845.6 3889.7 3893.0 3929.9 3950.7 26195.0 26333.9 27138.7 27406.5 27910.3 3040.4 3121.6 3132.0 3158.9 3188.2 262567.7 332418.0 332688.3 332757.0 332933.0 39994.0 41467.6 50674.7 50742.2 50749.0 43354.6 52364.1 53242.7 54968.0 55782.4 11231.0 13535.6 13607.8 13640.9 13646.3 11545.2 11588.9 11590.3 11618.9 11621.0 11757.9 11775.7 11776.1 11817.1 11844.8 5029.9 5201.2 5486.2 5575.5 5587.4 1058.3 1077.0 1090.0 1138.4 1141.7 22006.8 25591.6 26533.5 26591.6 26749.5 1020.7 1143.7 1166.2 1196.9 1201.5 13337.6 13697.7 13953.0 13958.0 14037.2 415360.0 415442.0 416393.0 416914.0 417464.0 53860.9 53878.0 53905.5 53928.5 53986.5 1389.9 1445.3 1447.5 1449.2 1452.0 25242.4 26013.3 26224.6 26295.5 26394.5 43330.0 43413.3 43474.6 43485.3 43615.8 423007.0 423926.0 424246.0 424634.0 424763.0 32120.4 33042.0 33045.7 33104.2 33155.7 39624.6 41599.4 41813.0 42662.8 42709.4 34277.0 34366.0 34366.7 34399.7 35553.5 34227.5 34314.7 35357.3 35457.0 35499.3 34188.8 34519.5 35117.5 35196.6 35215.5 29155.0 30640.7 30875.1 30884.4 31198.1 18235.9 18354.5 20151.8 23779.0 23864.3 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:39902.59 Median:27439.73 stddev:113893.91 (415.1%) stddev-sans-first:114174.76 03:23:00 INFO - PROCESS | 1641 | Values: 385.7 405.2 409.8 425.6 448.9 13261.5 20983.3 22100.2 22379.6 22456.9 20454.2 20901.9 21042.6 21325.7 21856.3 4924.6 6209.0 6345.5 6468.6 6520.8 5260.3 6446.8 6449.7 6456.4 6456.7 6343.4 6350.5 6435.9 6437.9 6477.3 6272.6 6325.6 6406.1 6413.1 6441.5 6180.2 6209.8 6243.5 6254.6 6266.9 24476.0 25483.9 25657.0 25894.7 25938.6 3096.8 3313.6 3337.0 3342.7 3369.5 15751.4 15758.9 15790.8 15797.7 15852.5 1908.9 2013.7 2076.6 2101.9 2120.1 152951.2 156956.0 157600.7 159627.0 163630.0 14782.9 18963.8 19972.6 20121.7 20176.0 24328.5 28940.9 30492.0 31551.8 31920.4 8408.5 8799.7 8916.3 9470.4 9822.6 7199.9 7387.2 7393.3 8237.7 8252.7 9207.0 9211.4 9332.9 9414.5 9439.2 3925.9 3946.5 3972.9 3989.3 3991.7 774.4 879.0 886.1 886.2 921.0 21310.9 21876.5 21877.9 21923.9 22195.9 767.5 896.5 916.8 919.1 927.1 8993.6 10770.1 11256.8 11405.3 11452.0 380658.0 533222.0 774181.0 784218.0 803800.0 129471.0 151923.2 154428.5 155131.0 160025.2 1159.6 1198.3 1205.5 1245.0 1251.5 19401.7 19694.7 20188.8 20200.2 20207.9 33912.0 50771.7 64832.7 65940.3 66525.0 76816.0 87008.7 87796.0 88949.0 89731.8 11388.0 11402.9 11577.7 11675.6 11828.9 10128.6 12288.9 12322.4 12368.7 12665.7 5892.0 7688.0 9966.7 10983.5 11391.0 10696.6 10845.2 10850.2 11145.8 11168.9 8114.9 11075.2 11085.6 11331.6 11388.6 11428.3 11503.5 11582.7 11786.6 11832.1 10790.1 10838.9 11102.3 11203.4 11344.8 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:6665.22 Median:3458.61 stddev:4203.29 (121.5%) stddev-sans-first:4197.33 03:23:00 INFO - PROCESS | 1641 | Values: 1524.4 1537.1 1561.4 1576.6 1579.6 10523.7 11084.2 11089.1 11093.9 11098.9 10466.6 10847.4 11016.9 11022.1 11023.1 2364.5 2396.4 2400.8 2402.6 2403.0 2331.0 2349.5 2357.3 2361.7 2364.4 2342.7 2354.4 2359.5 2364.8 2366.0 2299.4 2321.3 2326.1 2328.7 2329.0 2277.0 2333.9 2338.4 2338.5 2345.6 10704.7 10772.5 10773.4 10781.3 10789.7 5300.5 5681.0 5701.2 5716.8 5727.2 2972.0 3364.1 3414.3 3428.3 3586.9 1014.8 1137.2 1144.6 1183.9 1209.6 13714.7 14076.5 14088.1 15497.2 15589.0 4101.2 4181.4 4207.2 4224.2 4455.2 11524.2 11525.3 11545.1 11559.2 11569.9 5607.2 5615.2 5619.8 5647.8 5648.1 4907.4 5091.2 5155.9 5161.7 5171.5 3572.1 3666.2 3701.3 3740.7 3743.9 953.1 955.2 955.9 972.1 972.6 757.7 773.1 789.2 796.2 803.8 6429.8 6578.9 6626.1 6641.2 6709.9 961.6 963.2 968.0 973.4 982.5 3489.0 4336.9 4388.4 4395.8 4512.8 13609.2 13834.9 13866.7 13912.6 13937.4 13673.9 13803.7 13872.0 13876.4 13881.0 9904.9 9985.2 10049.7 10312.0 10332.9 5701.7 6620.2 6638.8 6671.5 6855.0 11940.9 12116.9 12151.6 12312.0 12358.3 10239.4 11200.8 12469.5 12482.4 12553.9 8937.5 9226.3 9386.8 9393.2 9394.3 8457.8 10177.7 10199.3 10291.2 10377.4 9075.2 9120.8 9178.2 9195.4 9358.8 9165.0 9291.5 9325.0 9343.0 9429.7 7707.2 7854.3 7937.7 7942.3 7949.8 5557.4 5746.9 5778.1 5897.8 5979.4 5879.4 5956.8 6023.6 6028.9 6211.0 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4431.08 Median:4742.62 stddev:1191.80 (25.1%) stddev-sans-first:1155.47 03:23:00 INFO - PROCESS | 1641 | Values: 368.1 377.9 384.6 384.7 387.6 4574.8 4785.6 4998.3 5074.3 5082.7 3837.5 4165.7 4345.6 4421.7 4851.5 3767.7 4174.5 4265.9 4286.2 4289.5 3545.7 4097.2 4317.5 4329.8 4333.3 3745.4 3821.0 4194.8 4224.7 4234.6 4250.7 4274.4 4276.5 4291.3 4299.6 3250.5 3688.7 4060.6 4090.7 4165.0 4729.2 4828.7 4835.8 4838.9 4910.6 4309.4 4358.0 4957.8 4959.4 4978.9 4359.6 5317.5 5321.1 5328.8 5336.5 3852.0 4025.8 4182.5 4400.3 4456.8 4869.0 4916.4 5111.4 5576.3 5598.8 3791.1 4346.5 4566.9 4695.1 4752.7 4166.0 4213.4 4760.2 4790.9 4799.5 4949.2 4969.4 4984.3 4987.0 4998.8 4126.1 5100.2 5253.2 5348.9 5377.0 1480.8 1537.9 1548.0 1641.5 1657.3 1073.0 1202.5 1218.3 1256.8 1348.4 4060.5 4603.7 5003.1 5005.7 5033.9 4601.5 4705.1 5105.4 5259.8 5450.7 4168.7 4615.6 4639.1 4999.0 4999.8 2818.8 2828.7 2831.7 2848.6 2862.3 5680.3 5681.5 5697.4 5706.7 5731.4 4495.5 5171.1 5397.7 5550.3 5636.5 5071.4 5592.9 5620.7 5699.8 5708.6 4488.9 4631.0 4915.8 5450.5 5489.6 4505.7 5042.5 5098.8 5264.6 5370.8 4870.6 4943.0 5600.4 5645.4 5689.0 4385.3 4719.9 4720.6 4749.4 4783.1 4682.6 5274.5 5295.8 5431.4 5506.3 4417.5 4632.5 4662.6 5200.8 5214.8 4560.8 4735.9 5170.4 5220.3 5340.4 4524.5 4882.0 5004.4 5068.7 5250.3 4243.5 4390.2 4570.7 5308.7 5343.0 4144.5 4912.6 5194.3 5271.7 5273.7 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:20653.16 Median:4341.57 stddev:30511.75 (702.8%) stddev-sans-first:30560.62 03:23:00 INFO - PROCESS | 1641 | Values: 716.3 735.6 775.7 830.2 844.3 13427.3 15087.4 15238.2 15933.6 15938.6 14539.0 14566.0 14569.3 14648.3 14659.7 890.6 908.8 916.3 936.0 946.6 900.9 912.4 915.0 916.4 934.8 967.0 967.8 968.5 970.1 970.5 960.8 961.6 962.8 963.6 965.1 716.1 716.1 717.2 717.7 718.0 15577.7 15888.6 15938.1 16022.0 16270.7 12484.9 13928.6 14085.3 14241.0 14258.9 11816.8 11884.0 11892.2 11913.2 12094.7 3581.6 3643.0 3731.9 3760.6 3876.2 101343.0 110135.0 110612.4 112173.0 115090.0 10475.5 10554.2 10895.8 11148.3 11220.2 19887.9 22180.0 22262.2 22365.3 22562.5 7816.0 7825.0 7912.8 7928.8 8005.5 4207.7 4301.6 4304.6 4378.5 4439.2 3483.9 3565.3 3590.8 3591.1 3591.2 641.1 653.9 660.2 660.6 662.6 654.0 669.9 678.8 709.9 711.6 7758.5 10214.7 10241.8 10374.3 10409.3 669.2 680.8 710.0 720.6 724.4 4617.8 4909.9 4953.9 4956.5 4959.7 103392.0 103999.0 104636.7 104886.0 106098.0 92493.5 93774.1 94263.1 95053.5 96432.0 80194.0 80950.2 82868.9 83958.6 85005.1 9220.9 9325.2 9509.6 9547.9 9562.9 50723.2 50893.7 50993.0 52090.7 52219.7 65322.0 65409.0 66722.7 66841.0 67984.0 11016.2 11326.5 11331.7 11349.4 11990.6 12293.7 12317.7 12361.3 12433.1 13093.3 11219.0 11349.8 11478.2 11689.8 12060.2 11712.4 11944.3 12051.6 12077.5 12101.2 11373.7 11790.2 11914.6 11916.4 12394.6 9341.4 10034.8 10059.5 10219.1 10618.9 9680.6 9766.7 9792.4 9865.0 9961.4 03:23:00 INFO - PROCESS | 1641 | -------- Summary: end -------- 03:23:00 INFO - PROCESS | 1641 | 03:23:00 INFO - TEST-INFO | 1641: exit 0 03:23:00 INFO - TEST-OK | dromaeo_css | took 1120976ms 03:23:00 INFO - TEST-START | kraken 03:23:00 INFO - operating with platform_type : mac_ 03:23:00 INFO - Initialising browser for kraken test... 03:23:00 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpWxNWGd/profile http://localhost:49240/getInfo.html) 03:23:03 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 03:23:03 INFO - PROCESS | 1652 | colorDepth:24 03:23:03 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 03:23:03 INFO - PROCESS | 1652 | __metrics 03:23:03 INFO - PROCESS | 1652 | 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" 03:23:03 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:23:03 INFO - TEST-INFO | 1652: exit 0 03:23:03 INFO - Browser initialized. 03:23:03 INFO - Running cycle 1/1 for kraken test... 03:23:03 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpWxNWGd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:16 INFO - PROCESS | 1653 | RSS: Main: 214392832 03:23:16 INFO - PROCESS | 1653 | 03:23:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:19 INFO - PROCESS | 1653 | RSS: Main: 267665408 03:23:19 INFO - PROCESS | 1653 | 03:23:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 03:23:23 INFO - PROCESS | 1653 | RSS: Main: 277508096 03:23:23 INFO - PROCESS | 1653 | 03:23:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 03:23:26 INFO - PROCESS | 1653 | RSS: Main: 373993472 03:23:26 INFO - PROCESS | 1653 | 03:23:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 03:23:29 INFO - PROCESS | 1653 | RSS: Main: 277905408 03:23:29 INFO - PROCESS | 1653 | 03:23:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:32 INFO - PROCESS | 1653 | RSS: Main: 278888448 03:23:32 INFO - PROCESS | 1653 | 03:23:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:35 INFO - PROCESS | 1653 | RSS: Main: 322256896 03:23:35 INFO - PROCESS | 1653 | 03:23:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:39 INFO - PROCESS | 1653 | RSS: Main: 321310720 03:23:39 INFO - PROCESS | 1653 | 03:23:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 03:23:42 INFO - PROCESS | 1653 | RSS: Main: 317489152 03:23:42 INFO - PROCESS | 1653 | 03:23:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:45 INFO - PROCESS | 1653 | RSS: Main: 295657472 03:23:45 INFO - PROCESS | 1653 | 03:23:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:47 INFO - PROCESS | 1653 | RSS: Main: 297672704 03:23:47 INFO - PROCESS | 1653 | 03:23:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:23:50 INFO - PROCESS | 1653 | RSS: Main: 303783936 03:23:50 INFO - PROCESS | 1653 | 03:23:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:23:54 INFO - PROCESS | 1653 | RSS: Main: 308314112 03:23:54 INFO - PROCESS | 1653 | 03:23:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:23:57 INFO - PROCESS | 1653 | RSS: Main: 310136832 03:23:57 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 03:23:59 INFO - PROCESS | 1653 | RSS: Main: 354557952 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | __start_tp_report 03:23:59 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 03:23:59 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 03:23:59 INFO - PROCESS | 1653 | |i|pagename|runs| 03:23:59 INFO - PROCESS | 1653 | |0;ai-astar;117;116;114;115;115;126;155;116;116;115 03:23:59 INFO - PROCESS | 1653 | |1;audio-beat-detection;129;111;105;140;109;107;107;107;125;108 03:23:59 INFO - PROCESS | 1653 | |2;audio-dft;183;180;180;184;183;183;184;182;184;183 03:23:59 INFO - PROCESS | 1653 | |3;audio-fft;79;61;61;91;61;62;59;59;77;76 03:23:59 INFO - PROCESS | 1653 | |4;audio-oscillator;87;69;87;71;71;68;82;69;69;85 03:23:59 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;86;86;87;86;85;87;86;93;86 03:23:59 INFO - PROCESS | 1653 | |6;imaging-darkroom;93;94;94;94;93;94;94;94;94;93 03:23:59 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;91;130;85;83;85;83;85;86;84 03:23:59 INFO - PROCESS | 1653 | |8;json-parse-financial;67;63;63;62;62;71;74;85;102;101 03:23:59 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;53;61;70;62;59;55;56;56;55;57 03:23:59 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;83;84;86;86;86;85;88;87;110 03:23:59 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;142;141;147;140;158;144;140;137;137;139 03:23:59 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;165;163;161;155;164;162;161;163;160;163 03:23:59 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;64;65;65;64;64;67;77;83;80;80 03:23:59 INFO - PROCESS | 1653 | __end_tp_report 03:23:59 INFO - PROCESS | 1653 | __start_cc_report 03:23:59 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2052 03:23:59 INFO - PROCESS | 1653 | __end_cc_report 03:23:59 INFO - PROCESS | 1653 | __startTimestamp1489487039547__endTimestamp 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | ------- Summary: start ------- 03:23:59 INFO - PROCESS | 1653 | Number of tests: 14 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:120.50 Median:116.00 stddev:12.59 (10.9%) stddev-sans-first:13.29 03:23:59 INFO - PROCESS | 1653 | Values: 117.0 116.0 114.0 115.0 115.0 126.0 155.0 116.0 116.0 115.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:114.80 Median:110.00 stddev:12.08 (11.0%) stddev-sans-first:11.67 03:23:59 INFO - PROCESS | 1653 | Values: 129.0 111.0 105.0 140.0 109.0 107.0 107.0 107.0 125.0 108.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.51 (0.8%) stddev-sans-first:1.59 03:23:59 INFO - PROCESS | 1653 | Values: 183.0 180.0 180.0 184.0 183.0 183.0 184.0 182.0 184.0 183.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:68.60 Median:69.00 stddev:11.24 (16.3%) stddev-sans-first:11.27 03:23:59 INFO - PROCESS | 1653 | Values: 79.0 61.0 61.0 91.0 61.0 62.0 59.0 59.0 77.0 76.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:76.50 stddev:8.30 (10.8%) stddev-sans-first:7.75 03:23:59 INFO - PROCESS | 1653 | Values: 87.0 69.0 87.0 71.0 71.0 68.0 82.0 69.0 69.0 85.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:86.50 stddev:2.23 (2.6%) stddev-sans-first:2.37 03:23:59 INFO - PROCESS | 1653 | Values: 87.0 86.0 86.0 87.0 86.0 85.0 87.0 86.0 93.0 86.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:23:59 INFO - PROCESS | 1653 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:89.70 Median:85.00 stddev:14.34 (16.9%) stddev-sans-first:15.11 03:23:59 INFO - PROCESS | 1653 | Values: 85.0 91.0 130.0 85.0 83.0 85.0 83.0 85.0 86.0 84.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:75.00 Median:65.00 stddev:15.68 (24.1%) stddev-sans-first:16.36 03:23:59 INFO - PROCESS | 1653 | Values: 67.0 63.0 63.0 62.0 62.0 71.0 74.0 85.0 102.0 101.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:4.95 (8.5%) stddev-sans-first:4.85 03:23:59 INFO - PROCESS | 1653 | Values: 53.0 61.0 70.0 62.0 59.0 55.0 56.0 56.0 55.0 57.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:7.82 (9.1%) stddev-sans-first:8.26 03:23:59 INFO - PROCESS | 1653 | Values: 86.0 83.0 84.0 86.0 86.0 86.0 85.0 88.0 87.0 110.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:141.50 stddev:6.24 (4.4%) stddev-sans-first:6.62 03:23:59 INFO - PROCESS | 1653 | Values: 142.0 141.0 147.0 140.0 158.0 144.0 140.0 137.0 137.0 139.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:163.00 stddev:2.79 (1.7%) stddev-sans-first:2.69 03:23:59 INFO - PROCESS | 1653 | Values: 165.0 163.0 161.0 155.0 164.0 162.0 161.0 163.0 160.0 163.0 03:23:59 INFO - PROCESS | 1653 | 03:23:59 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:72.00 stddev:8.01 (11.1%) stddev-sans-first:8.09 03:23:59 INFO - PROCESS | 1653 | Values: 64.0 65.0 65.0 64.0 64.0 67.0 77.0 83.0 80.0 80.0 03:23:59 INFO - PROCESS | 1653 | -------- Summary: end -------- 03:23:59 INFO - PROCESS | 1653 | 03:24:00 INFO - TEST-INFO | 1653: exit 0 03:24:00 INFO - TEST-OK | kraken | took 59680ms 03:24:00 INFO - SUITE-END | took 1180s 03:24:00 INFO - Completed test suite (00:19:40) 03:24:00 INFO - javascript benchmark 03:24:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7521.5300245293865, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.8129129639433, 3182.4589819730645, 3393.4061539230634, 3411.4030044742162, 3447.3450044491547, 5816.709164541772, 5882.205902203202, 5896.823095307137, 5907.379725128864, 5910.615809972349, 5875.970620146893, 5938.990371636822, 5947.0, 5955.255593050869, 5961.761529538824, 5295.682259064449, 5299.152135658286, 5343.7328133593355, 5420.051490989081, 5423.810166644168, 5233.450487698794, 5248.0815857225025, 5295.179247216687, 5434.565234781208, 5454.645448045884, 5301.0, 5335.546478549328, 5336.67979921204, 5337.14605663094, 5338.67967921924, 4401.713888597231, 5306.124489459235, 5323.387810401776, 5331.466853314657, 5334.67991920486, 4363.0, 5163.173892177271, 5277.8416647500635, 5290.68255904647, 5308.124159513675, 5895.056790913433, 5905.2323197984415, 5909.911351329733, 5912.674802885839, 5916.26046744157, 6245.094461303085, 6272.341404152589, 6280.87438251237, 6283.371662833726, 6304.401081897213, 6316.62100273985, 6318.589291696025, 6318.842028949267, 6321.494280457552, 6384.265809431882, 4917.237828136609, 6066.332703402622, 6066.363031881633, 6072.271327440735, 6073.635581865102, 6262.624242545462, 6551.475881929434, 6595.307492713244, 6610.206775186912, 6616.702248398786, 6216.720247588869, 6225.750969961241, 6238.189035425366, 6238.781642642486, 6249.25008998923, 6139.075791860876, 6254.718537665725, 6312.084747711556, 6338.397852204033, 6342.5560210785725, 6289.8742025159245, 6325.810225693236, 6327.335629758901, 6329.683515824282, 6344.8413789654705, 6314.052892066226, 6316.778912738032, 6322.652254126067, 6323.652199129, 6334.9366506334345, 4838.685485443435, 5028.396592408934, 5029.874253143701, 5037.19404895215, 5101.744912754348, 4487.887802804956, 4497.055618320124, 4504.301833215857, 4512.390827238347, 4515.616172625364, 5799.449052340021, 5846.327672317653, 5846.970765146147, 5850.970745146247, 5872.853178670567, 6139.969300153471, 6306.369363063657, 6328.778492752732, 6338.176037115146, 6358.237011558643, 6015.879682406327, 6017.007193812972, 6023.45788879003, 6027.427394397525, 6065.363136870653, 5640.153976903415, 5641.294838145232, 5644.238027866268, 5653.491185793216, 5673.886522269531, 6315.621062736251, 6383.425491705769, 6664.067030615718, 6679.231888332807, 6683.231428385798, 6309.432151106423, 6328.240611126695, 6337.081123237197, 6337.8732425352155, 6339.873202536016, 6443.097966284818, 6454.741810327534, 6548.377904099103, 6581.14445122131, 6678.49911256648, 6266.561340706289, 6306.117143599991, 6334.588251763621, 6334.588251763805, 6336.17629708135, 6389.393007664265, 6392.584482008655, 6398.584092034003, 6412.487001039999, 6418.037294405876, 6125.816225513242, 6139.539534534839, 6145.187169784835, 6170.845728856814, 6290.811275661737, 6154.5384096192065, 6184.196054512884, 6204.5967012144065, 6215.968920155551, 6216.285127210429, 5289.624697578581, 5816.854578635399, 6112.449879510866, 6136.907946380718, 6141.355157708376, 6215.9378406215355, 6239.407256310643, 6239.594426362272, 6300.0, 6314.368563143649, 5935.940640593539, 5952.315483719428, 6061.545384096298, 6154.1999540059505, 6242.65665388408], "value": 5815.277957244914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.5353541410567, 811.3995643224014, 871.0114020586636, 892.6607889002174, 893.6336102198092, 27243.31891702706, 39112.804435977814, 39383.0, 39782.60217397825, 39917.401238981365, 40153.7992310038, 40413.59586404135, 40455.59544404555, 40492.59507404925, 40551.59448405515, 7252.6011069391425, 8994.460332380046, 9109.0, 9148.542572871329, 9151.908480915172, 7299.19708832028, 10747.0, 10924.28992115514, 11111.611093611726, 11122.0, 10911.181661375389, 10922.781544369147, 10939.234253602252, 10962.506687199055, 10985.505652245669, 7106.538075025107, 10895.673129806119, 10925.453727313603, 10925.890741092606, 10942.890571094267, 7199.820004499877, 7241.637918104074, 7242.601656908868, 7254.5647261164495, 10556.894431055745, 37912.81043594792, 38117.0, 38128.237435251416, 38128.42807357892, 38187.0, 3845.61543845616, 3889.68882489403, 3893.0, 3929.862454814068, 3950.6839452843706, 26195.0, 26333.94664213429, 27138.728612713818, 27406.45187096267, 27910.302242443897, 3040.361524079946, 3121.641011283709, 3131.984340078285, 3158.921026974321, 3188.21888637283, 262567.6871615649, 332418.0, 332688.33655831567, 332757.0, 332933.0, 39994.0001499959, 41467.58532414637, 50674.746626266635, 50742.23886641629, 50749.0, 43354.56645433505, 52364.0726945473, 53242.73378633082, 54968.0, 55782.44217557772, 11231.0, 13535.59393218205, 13607.795883061763, 13640.86359136396, 13646.317684115755, 11545.24955877882, 11588.94205528984, 11590.304581725124, 11618.88381116195, 11621.012213961907, 11757.941210293893, 11775.705607359712, 11776.11679124069, 11817.054635629129, 11844.76310473803, 5029.949700502948, 5201.245819356172, 5486.231927530149, 5575.526080283222, 5587.357453892773, 1058.259163675749, 1077.0, 1089.9618513352152, 1138.3795831271977, 1141.697450175704, 22006.779932200792, 25591.61612575813, 26533.46933061328, 26591.596371160304, 26749.465010700067, 1020.6784862768204, 1143.656902929118, 1166.1720178673238, 1196.8922796948316, 1201.537408097871, 13337.599872003855, 13697.726045479034, 13952.953528485405, 13958.0, 14037.227952462508, 415360.0, 415442.0, 416393.0, 416914.0, 417464.0, 53860.92278154415, 53878.0, 53905.46094539083, 53928.46071539313, 53986.46013539893, 1389.8540653231264, 1445.3206992713617, 1447.471672839406, 1449.2029383839058, 1452.0271418149864, 25242.36894077663, 26013.349666258495, 26224.606630900933, 26295.4740905177, 26394.472110557297, 43330.0, 43413.34879976866, 43474.56525434705, 43485.3477197836, 43615.781921090194, 423007.0, 423926.0, 424246.0, 424634.0, 424763.0, 32120.35759284848, 33042.0, 33045.67817287282, 33104.1723956903, 33155.67377304881, 39624.57591441542, 41599.37600936049, 41812.98244210714, 42662.786686067615, 42709.35935961025, 34277.0, 34366.0, 34366.656333436345, 34399.656003439646, 35553.466697999036, 34227.4865877017, 34314.656853431145, 35357.292854143285, 35457.0, 35499.290014199054, 34188.82905585456, 34519.4822077674, 35117.473237900944, 35196.648033519334, 35215.47176792401, 29155.0, 30640.693593063785, 30875.073747787603, 30884.382312354075, 31198.064058078293, 18235.908820455814, 18354.541136471697, 20151.790892546494, 23779.0, 23864.284071477883], "value": 18217.652779411426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7454080306998, 405.2057966385884, 409.8299205829579, 425.58505457179257, 448.90797386535763, 13261.535846245384, 20983.265585704503, 22100.22649207278, 22379.55240895181, 22456.8877155614, 20454.181832726674, 20901.895490522526, 21042.579148417022, 21325.68011479829, 21856.344309670694, 4924.630652701044, 6209.0, 6345.540525679096, 6468.611883287018, 6520.804375868708, 5260.316158899338, 6446.838829029289, 6449.742010319582, 6456.386643268882, 6456.677166141698, 6343.365663433643, 6350.491960643138, 6435.871282574346, 6437.903431448532, 6477.319881412454, 6272.623642581414, 6325.620462772225, 6406.0711196876655, 6413.134226879405, 6441.4524765395, 6180.165677633507, 6209.813705588839, 6243.531735119839, 6254.562180647356, 6266.87466250677, 24476.0, 25483.872580636977, 25657.0, 25894.741052589423, 25938.610920836203, 3096.7987080839675, 3313.6355000949875, 3337.0, 3342.715869151125, 3369.4608862582113, 15751.448699295584, 15758.921205394014, 15790.763138552931, 15797.68404631901, 15852.524424267174, 1908.9427317180507, 2013.6677448221026, 2076.584683063378, 2101.857722704551, 2120.120150137691, 152951.2352438242, 156956.0, 157600.66880312125, 159627.0, 163630.0, 14782.890311651514, 18963.81036189648, 19972.600547988957, 20121.698174527395, 20175.99120043992, 24328.513429731305, 28940.855295723388, 30492.0, 31551.84224078911, 31920.361592768015, 8408.495490270481, 8799.736007919773, 8916.286697064219, 9470.431774093577, 9822.607095716092, 7199.9280007200305, 7387.224341444071, 7393.297636724503, 8237.670493180325, 8252.669893204205, 9206.953965230265, 9211.355205135711, 9332.860007099898, 9414.529273536296, 9439.24486041115, 3925.9018524537114, 3946.5264168299414, 3972.900677483086, 3989.3218152913496, 3991.720579559461, 774.3766268154077, 879.0, 886.1050339157497, 886.1714297132073, 920.9539523023822, 21310.893445532674, 21876.45308867291, 21877.890610547165, 21923.890380547997, 22195.889020554794, 767.4896194030907, 896.5203616065373, 916.7891384981492, 919.1084647891535, 927.0868194828089, 8993.595288212045, 10770.084542813793, 11256.774864502828, 11405.315681059163, 11452.0, 380658.0, 533222.0, 774181.0, 784218.0, 803800.0, 129471.0, 151923.24038379738, 154428.45571544365, 155131.0, 160025.19987400222, 1159.5999380213814, 1198.3469009389903, 1205.52984336109, 1244.975100497985, 1251.5181655062866, 19401.70897436568, 19694.704579431032, 20188.788672679686, 20200.19199232073, 20207.898960505103, 33912.0, 50771.74614126905, 64832.67583662052, 65940.34059659342, 66525.0, 76816.0, 87008.69486957828, 87796.0, 88949.0, 89731.78352705912, 11387.975082242638, 11402.885971140182, 11577.6526704199, 11675.649730508097, 11828.881711182778, 10128.645497407555, 12288.938555307166, 12322.445489953154, 12368.690782730504, 12665.683357916127, 5892.0, 7687.961560192163, 9966.651167209113, 10983.450827458435, 11391.031762300297, 10696.62561810333, 10845.240833141605, 10850.240483166102, 11145.777084458428, 11168.944155279172, 8114.878276825734, 11075.224734268524, 11085.612003579836, 11331.603393881174, 11388.601398950997, 11428.25716328436, 11503.48234329474, 11582.6525204244, 11786.646400607653, 11832.112591555495, 10790.136789057013, 10838.945805270923, 11102.2783519071, 11203.383813890314, 11344.829827552758], "value": 11091.834456383887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.382625036859, 1537.123839411536, 1561.3910574875802, 1576.6294920693638, 1579.6366835627805, 10523.684289471308, 11084.168687348461, 11089.05743011845, 11093.889061109387, 11098.944505277472, 10466.633667821608, 10847.403392813392, 11016.944915275433, 11022.118230541557, 11023.118150547956, 2364.538914911597, 2396.364963284731, 2400.7719266669637, 2402.615581506959, 2402.95194096118, 2330.976690233101, 2349.5183487385043, 2357.3045951444365, 2361.728401233854, 2364.408897775556, 2342.6954495915593, 2354.3996280948336, 2359.539889721505, 2364.8344615876895, 2366.0299277296313, 2299.3561802695103, 2321.257197696738, 2326.139328448468, 2328.7089113860766, 2328.953420931589, 2277.0436416705024, 2333.8599684018845, 2338.4153961509624, 2338.4621537046573, 2345.566070277004, 10704.732381690443, 10772.461376931122, 10773.353598784099, 10781.299215550964, 10789.676309710721, 5300.496452836975, 5681.034224181858, 5701.230333904911, 5716.771329146829, 5727.198192253088, 2972.0, 3364.1253274148653, 3414.334204830059, 3428.2629234714404, 3586.910327241814, 1014.7818219082859, 1137.1585027079984, 1144.6279959013355, 1183.923045002072, 1209.6008317255285, 13714.725705485935, 14076.507322243775, 14088.084274522022, 15497.225138743017, 15589.0, 4101.200265948111, 4181.372794080912, 4207.221663992172, 4224.155168966219, 4455.1535208310315, 11524.193306468635, 11525.250858694159, 11545.076393888468, 11559.190856639954, 11569.942150289364, 5607.186957891083, 5615.241942337814, 5619.831405057855, 5647.774089036475, 5648.068068768607, 4907.411110666742, 5091.210862316347, 5155.871103222449, 5161.690298582097, 5171.482851714798, 3572.1248294167576, 3666.175110600147, 3701.3152566775234, 3740.7007439404783, 3743.8502459901842, 953.0897992417225, 955.2232846904751, 955.9235261179089, 972.0522490571777, 972.6060945317158, 757.6514803190483, 773.1070613441484, 789.2305002622512, 796.243568609823, 803.8231589050399, 6429.7749578764515, 6578.901316480256, 6626.105475760807, 6641.236257830315, 6709.932900671029, 961.6057416459358, 963.1668606655332, 967.9564419601135, 973.4159504297506, 982.5431174503747, 3488.965110348864, 4336.9132617348105, 4388.363687265329, 4395.846145384896, 4512.842050528216, 13609.183448993092, 13834.93082534581, 13866.722665546633, 13912.58262252134, 13937.372818223204, 13673.86326136726, 13803.723925521634, 13872.028957973047, 13876.444942202199, 13880.958928080434, 9904.900950990543, 9985.1512621428, 10049.748756281006, 10312.0, 10332.896671033193, 5701.657900525815, 6620.184800230729, 6638.800835974928, 6671.532992690465, 6855.040294358694, 11940.880591193976, 12116.939415302868, 12151.574694885636, 12312.0, 12358.2585044894, 10239.436830974368, 11200.775984480102, 12469.5012199511, 12482.375881206084, 12553.932915702268, 8937.508437036025, 9226.261899048195, 9386.812263754824, 9393.154616084585, 9394.295427842802, 8457.788555286166, 10177.745556360855, 10199.337043092175, 10291.22815788804, 10377.429241391494, 9075.183233509017, 9120.787188271703, 9178.219851312713, 9195.448273103635, 9358.766030849283, 9165.0, 9291.48896810682, 9324.95337523308, 9343.0, 9429.669961551313, 7707.152213256425, 7854.332381747616, 7937.722179723682, 7942.324902383362, 7949.761507154794, 5557.416471270459, 5746.856328591652, 5778.104393818965, 5897.764089436546, 5979.402059793986, 5879.353271140086, 5956.76172953077, 6023.6385816851125, 6028.909566356596, 6211.0], "value": 5033.064838352223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.13488302489156, 377.8545260074871, 384.6134634692134, 384.66341950793054, 387.6162599026963, 4574.839880604171, 4785.641076919228, 4998.300577803546, 5074.340335756351, 5082.745862706864, 3837.5394952605725, 4165.708400411965, 4345.588712860405, 4421.6904816662845, 4851.490593487686, 3767.71897554832, 4174.457320548325, 4265.893352666177, 4286.185624731291, 4289.498675463594, 3545.6631619996188, 4097.221527909703, 4317.460317460317, 4329.805158767863, 4333.349997500369, 3745.4381842723537, 3820.961790382102, 4194.832206711728, 4224.683148763839, 4234.597713217239, 4250.659947204232, 4274.358846173068, 4276.48682158143, 4291.270484017725, 4299.570042995707, 3250.4961730931745, 3688.7417880748358, 4060.593940605945, 4090.6931980101613, 4165.0, 4729.162502498508, 4828.73441960692, 4835.848047618811, 4838.854834354975, 4910.607151427877, 4309.4397728295435, 4357.978210108961, 4957.752112394366, 4959.380077490314, 4978.90042199154, 4359.564043595647, 5317.46825317469, 5321.115585622479, 5328.813491527817, 5336.479103455536, 3852.036990752312, 4025.81238534633, 4182.477190351206, 4400.339949007643, 4456.818942980113, 4868.95131048692, 4916.410030796256, 5111.386633603955, 5576.302962129734, 5598.832035038955, 3791.0855018216175, 4346.47842258931, 4566.885827854264, 4695.107929493385, 4752.714837109785, 4165.958510372407, 4213.431186789744, 4760.190767569521, 4790.856274311776, 4799.520047995173, 4949.158643030693, 4969.378827646544, 4984.27727979441, 4986.950130498649, 4998.800047998039, 4126.122614210527, 5100.240417056184, 5253.1857562077175, 5348.930213957224, 5376.973115134478, 1480.8227459169987, 1537.8615924566618, 1547.9705995513084, 1641.5075477356745, 1657.32049859557, 1072.9946350268199, 1202.5129822421934, 1218.2873019283818, 1256.8428946381703, 1348.420179322881, 4060.5127384713433, 4603.723776573416, 5003.122580000529, 5005.74971251436, 5033.899322013539, 4601.469191944418, 4705.0828486338005, 5105.387353517527, 5259.789608415621, 5450.672959622435, 4168.749875007509, 4615.561521655437, 4639.072185562901, 4999.0, 4999.75001249936, 2818.788590855694, 2828.7454129128064, 2831.6743574488787, 2848.61543691599, 2862.3416614178855, 5680.318361796611, 5681.471745073485, 5697.430256974352, 5706.686132262683, 5731.369549349568, 4495.483019452739, 5171.146760784503, 5397.652021370638, 5550.30810057122, 5636.464535869086, 5071.410373611887, 5592.888142237214, 5620.662760234399, 5699.800506982236, 5708.600397972102, 4488.865334039984, 4630.953690463052, 4915.754212289443, 5450.482204190595, 5489.58828087887, 4505.684602077823, 5042.520960508746, 5098.818968445838, 5264.605154613496, 5370.758315875873, 4870.634702397405, 4942.950570494393, 5600.439956004367, 5645.350784659817, 5689.0, 4385.254506733927, 4719.929201061918, 4720.598749106364, 4749.382580264543, 4783.091212669721, 4682.648801339845, 5274.498922602346, 5295.7616907240035, 5431.402545719889, 5506.284183056177, 4417.469903611587, 4632.4712844761825, 4662.573008838433, 5200.843974680765, 5214.791408343775, 4560.817567297271, 4735.863392785775, 5170.37955445349, 5220.347456567929, 5340.359156901041, 4524.502304746409, 4881.975590122027, 5004.449510553909, 5068.746562671926, 5250.2674117540355, 4243.511996120362, 4390.209762242699, 4570.6800523963, 5308.654937429054, 5342.958123165945, 4144.52337981136, 4912.582430493448, 5194.272801807674, 5271.68369897792, 5273.683578985273], "value": 4097.149733244892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.323074694414, 735.6358602491764, 775.7478819383698, 830.2278880641004, 844.2612713875361, 13427.328633568331, 15087.396504139835, 15238.238088095579, 15933.601659958507, 15938.601534961617, 14539.0, 14565.980381373309, 14569.344379502947, 14648.34082466289, 14659.706805863876, 890.5591732092607, 908.8318661047695, 916.331078312832, 935.9906400935971, 946.6260826973341, 900.8513595256775, 912.370464379576, 914.9588268527899, 916.3677062826662, 934.8410770169088, 967.0184762466102, 967.7532229281559, 968.5109019944917, 970.112347202309, 970.5438443931376, 960.7982323712029, 961.5721004153155, 962.841131213349, 963.6097380560814, 965.0879918477042, 716.0941409117471, 716.1442076718324, 717.2289788477408, 717.6878058044715, 718.0199028326349, 15577.688446231125, 15888.60278493047, 15938.12340321282, 16021.958572692738, 16270.674586508203, 12484.937575312157, 13928.58214253574, 14085.295735213302, 14241.0, 14258.857411425857, 11816.784992613852, 11884.049276057895, 11892.219917528444, 11913.166078374517, 12094.697632559168, 3581.606023337431, 3642.981785091084, 3731.869384571527, 3760.6051364606597, 3876.205377897524, 101343.0, 110135.0, 110612.4469377656, 112173.0, 115090.0, 10475.47622618866, 10554.2084343673, 10895.782084358269, 11148.331100134017, 11220.214584979136, 19887.900560497106, 22180.0, 22262.22082227114, 22365.329040128498, 22562.54874902493, 7815.996356363524, 7825.0218722659665, 7912.762617121495, 7928.84142317162, 8005.479643823133, 4207.684423668237, 4301.591348821857, 4304.634106101016, 4378.496472905656, 4439.156560253606, 3483.860645574199, 3565.2691198304287, 3590.8025058621506, 3591.102224443889, 3591.2099338145567, 641.0512441586478, 653.8953767397194, 660.1813750948885, 660.5838321857199, 662.5726406467898, 653.9574927629689, 669.8693754717881, 678.8031470873391, 709.9183593886769, 711.5837235217456, 7758.534487930629, 10214.693559193236, 10241.795164096677, 10374.27380083402, 10409.323393979366, 669.1501792723215, 680.7957612716166, 709.9964500177466, 720.6000669628406, 724.3589423360364, 4617.8152873884665, 4909.926351104737, 4953.851384458472, 4956.529129732669, 4959.677620954626, 103392.0, 103999.0, 104636.67543271898, 104886.0, 106098.0, 92493.53753231191, 93774.12451750926, 94263.0573694268, 95053.5247323759, 96432.0, 80194.0, 80950.19049809544, 82868.91300360313, 83958.58020709979, 85005.14994850096, 9220.907790922005, 9325.207357374427, 9509.61961521559, 9547.904520954702, 9562.856557151787, 50723.23915141202, 50893.74553127211, 50993.0, 52090.73954630203, 52219.73890130525, 65322.0, 65409.0, 66722.66554668976, 66841.0, 67984.0, 11016.228863979444, 11326.490307935997, 11331.716707082389, 11349.37578433161, 11990.580329688419, 12293.692657683629, 12317.692057698629, 12361.320127393079, 12433.06751993586, 13093.279869607262, 11219.0, 11349.829752553553, 11478.196526243082, 11689.766204675689, 12060.155789094679, 11712.355820429959, 11944.343061131374, 12051.638450846489, 12077.51689932393, 12101.152919295564, 11373.658790236306, 11790.174687771774, 11914.582989595323, 11916.404179791149, 12394.566190183301, 9341.392809467363, 10034.849477257992, 10059.49702514886, 10219.131373833308, 10618.938106189627, 9680.634743431372, 9766.658166964122, 9792.363496372998, 9865.0, 9961.356805495909], "value": 7471.621893501429, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 115.0, 115.0, 126.0, 155.0, 116.0, 116.0, 115.0], "value": 120.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 111.0, 105.0, 140.0, 109.0, 107.0, 107.0, 107.0, 125.0, 108.0], "value": 114.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 180.0, 184.0, 183.0, 183.0, 184.0, 182.0, 184.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 61.0, 91.0, 61.0, 62.0, 59.0, 59.0, 77.0, 76.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 87.0, 71.0, 71.0, 68.0, 82.0, 69.0, 69.0, 85.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 86.0, 85.0, 87.0, 86.0, 93.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 130.0, 85.0, 83.0, 85.0, 83.0, 85.0, 86.0, 84.0], "value": 89.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 62.0, 62.0, 71.0, 74.0, 85.0, 102.0, 101.0], "value": 75.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 61.0, 70.0, 62.0, 59.0, 55.0, 56.0, 56.0, 55.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 86.0, 86.0, 86.0, 85.0, 88.0, 87.0, 110.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 147.0, 140.0, 158.0, 144.0, 140.0, 137.0, 137.0, 139.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 155.0, 164.0, 162.0, 161.0, 163.0, 160.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 67.0, 77.0, 83.0, 80.0, 80.0], "value": 70.9, "unit": "score"}]}]} 03:24:00 INFO - Return code: 0 03:24:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:00 ERROR - # TBPL SUCCESS # 03:24:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:00 INFO - 2017-03-14 03:24:00.869 screenresolution[1657:10398] starting screenresolution argv=screenresolution get 03:24:00 INFO - 2017-03-14 03:24:00.872 screenresolution[1657:10398] Display 0: 1600x1200x32@60 03:24:00 INFO - 2017-03-14 03:24:00.878 screenresolution[1658:10401] starting screenresolution argv=screenresolution list 03:24:00 INFO - Available Modes on Display 0 03:24:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:01 INFO - Intel Iris: 03:24:01 INFO - Chipset Model: Intel Iris 03:24:01 INFO - Type: GPU 03:24:01 INFO - Bus: Built-In 03:24:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:01 INFO - Vendor: Intel (0x8086) 03:24:01 INFO - Device ID: 0x0a2e 03:24:01 INFO - Revision ID: 0x0009 03:24:01 INFO - Displays: 03:24:01 INFO - Display: 03:24:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:01 INFO - Display Serial Number: 1600x1200 60 03:24:01 INFO - Main Display: Yes 03:24:01 INFO - Mirror: Off 03:24:01 INFO - Online: Yes 03:24:01 INFO - Rotation: Supported 03:24:01 INFO - Return code: 0 03:24:01 INFO - Running post-action listener: _resource_record_post_action 03:24:01 INFO - [mozharness: 2017-03-14 10:24:01.124416Z] Finished run-tests step (success) 03:24:01 INFO - Running post-run listener: _resource_record_post_run 03:24:01 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39158784; Write bytes: 509908992; Read time: 375; Write time: 1702 03:24:01 INFO - TinderboxPrint: CPU usage
53.7% 03:24:01 INFO - TinderboxPrint: I/O read bytes / time
39,158,784 / 375 03:24:01 INFO - TinderboxPrint: I/O write bytes / time
509,908,992 / 1,702 03:24:01 INFO - TinderboxPrint: CPU idle
2,225.7 (46.3%) 03:24:01 INFO - TinderboxPrint: CPU system
955.7 (19.9%) 03:24:01 INFO - TinderboxPrint: CPU user
1,624.3 (33.8%) 03:24:01 INFO - TinderboxPrint: Swap in / out
247,685,120 / 0 03:24:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206281216; Write bytes: 202676224; Read time: 15714; Write time: 488 03:24:01 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 37049344; Write bytes: 296198144; Read time: 350; Write time: 1177 03:24:01 INFO - Running post-run listener: _upload_blobber_files 03:24:01 INFO - Blob upload gear active. 03:24:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24: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 03:24: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'] 03:24: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 03:24:01 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:24:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:24:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:02 INFO - (blobuploader) - INFO - Done attempting. 03:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:03 INFO - (blobuploader) - INFO - Done attempting. 03:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:04 INFO - (blobuploader) - INFO - Done attempting. 03:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:06 INFO - (blobuploader) - INFO - Done attempting. 03:24:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:24:06 INFO - Return code: 0 03:24:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:24:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:24:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c5b91c5c23ff062a80ac205c4c46492f972b2ea032d4ba8fe440da8386bf5206001dd0581123ee282ebea4a522b95c5f7d4893af6fdba48e12e56129a20e36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df017885cd54b506543394e00d1e16e8de28d1435c9ea957c61629a03ab31f46c004ea57e5beab96d654a74adea0c1d158ab9580d5776dabae6ec2460cf40408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8d745f30ad2758d4d4e6b45d1d3e4fd92716d9d9a6a9011a6f1735f542de50e6fcd2c346a74db78e7b6aefb4e2befed1387215152963ea9243a8abe3a1fa23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e69be2fa5ab7ff4f20d8a69f1b76414bd5eb8f3331e0b38471165156c190ee96728cfa6dec98788ad6309afbd93e2ad51e57cb72c187d44ca7421d7aff4c7ebf"} 03:24:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:24:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:24:06 INFO - Contents: 03:24:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c5b91c5c23ff062a80ac205c4c46492f972b2ea032d4ba8fe440da8386bf5206001dd0581123ee282ebea4a522b95c5f7d4893af6fdba48e12e56129a20e36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df017885cd54b506543394e00d1e16e8de28d1435c9ea957c61629a03ab31f46c004ea57e5beab96d654a74adea0c1d158ab9580d5776dabae6ec2460cf40408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8d745f30ad2758d4d4e6b45d1d3e4fd92716d9d9a6a9011a6f1735f542de50e6fcd2c346a74db78e7b6aefb4e2befed1387215152963ea9243a8abe3a1fa23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e69be2fa5ab7ff4f20d8a69f1b76414bd5eb8f3331e0b38471165156c190ee96728cfa6dec98788ad6309afbd93e2ad51e57cb72c187d44ca7421d7aff4c7ebf"} 03:24:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:24:06 INFO - Copying logs to upload dir... 03:24:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:24:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.901797 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-14 03:24:06.841036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:06.845110) ========= 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.T1EFubY78C/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.bULyUj2tJN/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/d6c5b91c5c23ff062a80ac205c4c46492f972b2ea032d4ba8fe440da8386bf5206001dd0581123ee282ebea4a522b95c5f7d4893af6fdba48e12e56129a20e36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df017885cd54b506543394e00d1e16e8de28d1435c9ea957c61629a03ab31f46c004ea57e5beab96d654a74adea0c1d158ab9580d5776dabae6ec2460cf40408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8d745f30ad2758d4d4e6b45d1d3e4fd92716d9d9a6a9011a6f1735f542de50e6fcd2c346a74db78e7b6aefb4e2befed1387215152963ea9243a8abe3a1fa23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e69be2fa5ab7ff4f20d8a69f1b76414bd5eb8f3331e0b38471165156c190ee96728cfa6dec98788ad6309afbd93e2ad51e57cb72c187d44ca7421d7aff4c7ebf"} build_url:https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010870 build_url: 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/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/d6c5b91c5c23ff062a80ac205c4c46492f972b2ea032d4ba8fe440da8386bf5206001dd0581123ee282ebea4a522b95c5f7d4893af6fdba48e12e56129a20e36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df017885cd54b506543394e00d1e16e8de28d1435c9ea957c61629a03ab31f46c004ea57e5beab96d654a74adea0c1d158ab9580d5776dabae6ec2460cf40408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8d745f30ad2758d4d4e6b45d1d3e4fd92716d9d9a6a9011a6f1735f542de50e6fcd2c346a74db78e7b6aefb4e2befed1387215152963ea9243a8abe3a1fa23", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e69be2fa5ab7ff4f20d8a69f1b76414bd5eb8f3331e0b38471165156c190ee96728cfa6dec98788ad6309afbd93e2ad51e57cb72c187d44ca7421d7aff4c7ebf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:06.881044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:06.881561) ========= 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.T1EFubY78C/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.bULyUj2tJN/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005226 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:06.932667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 03:24:06.933121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 03:24:06.933649) ========= ========= Total master_lag: 0.18 =========