builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0185 starttime: 1493922136.68 results: success (0) buildid: 20170504095619 builduid: f63e2a2a030245a595809f5819453b9a revision: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:16.679210) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:16.679690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:16.680002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:16.706290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:16.706973) ========= 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.TQdPHDeTKO/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.ipVsnSotlY/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-05-04 11:22:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 33.8M=0s 2017-05-04 11:22:16 (33.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141687 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:17.155021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:17.155331) ========= 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.TQdPHDeTKO/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.ipVsnSotlY/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.020536 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:17.199909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 11:22:17.200216) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d92d578f631e730dd9c1f1725d2ee81ccb3ed8de --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-beta --rev d92d578f631e730dd9c1f1725d2ee81ccb3ed8de --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TQdPHDeTKO/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.ipVsnSotlY/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-05-04 11:22:17,285 truncating revision to first 12 chars 2017-05-04 11:22:17,285 Setting DEBUG logging. 2017-05-04 11:22:17,285 attempt 1/10 2017-05-04 11:22:17,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d92d578f631e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 11:22:18,453 unpacking tar archive at: mozilla-beta-d92d578f631e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.424254 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 11:22:18.649633) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:18.650042) ========= script_repo_revision: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:18.650526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:18.650870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 11:22:18.671928) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-04 11:22:18.672634) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TQdPHDeTKO/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.ipVsnSotlY/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:22:18 INFO - MultiFileLogger online at 20170504 11:22:18 in /builds/slave/test 11:22:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:22:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:18 INFO - {'append_to_log': False, 11:22:18 INFO - 'base_work_dir': '/builds/slave/test', 11:22:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:22:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:18 INFO - 'branch': 'Mozilla-Beta', 11:22:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:18 INFO - 'config_files': ('talos/mac_config.py',), 11:22:18 INFO - 'default_actions': ('clobber', 11:22:18 INFO - 'read-buildbot-config', 11:22:18 INFO - 'download-and-extract', 11:22:18 INFO - 'populate-webroot', 11:22:18 INFO - 'create-virtualenv', 11:22:18 INFO - 'install', 11:22:18 INFO - 'run-tests'), 11:22:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:18 INFO - 'download_minidump_stackwalk': True, 11:22:18 INFO - 'download_symbols': 'ondemand', 11:22:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:18 INFO - 'gecko_profile': False, 11:22:18 INFO - 'gecko_profile_interval': 0, 11:22:18 INFO - 'installer_path': 'installer.exe', 11:22:18 INFO - 'log_level': 'info', 11:22:18 INFO - 'log_name': 'talos', 11:22:18 INFO - 'log_to_console': True, 11:22:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:22:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:22:18 INFO - 'opt_config_files': (), 11:22:18 INFO - 'pip_index': False, 11:22:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:22:18 INFO - 'cmd': ('bash', 11:22:18 INFO - '-c', 11:22:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:22:18 INFO - 'enabled': True, 11:22:18 INFO - 'halt_on_failure': False, 11:22:18 INFO - 'name': 'check_screen_resolution'},), 11:22:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:22:18 INFO - 'cmd': ('bash', 11:22:18 INFO - '-c', 11:22:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:22:18 INFO - 'enabled': True, 11:22:18 INFO - 'halt_on_failure': False, 11:22:18 INFO - 'name': 'check_screen_resolution'},), 11:22:18 INFO - 'run_cmd_checks_enabled': True, 11:22:18 INFO - 'suite': 'dromaeojs', 11:22:18 INFO - 'system_bits': '32', 11:22:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:18 INFO - 'title': 't-yosemite-r7-0185', 11:22:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:18 INFO - 'use_talos_json': True, 11:22:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:18 INFO - 'work_dir': 'build'} 11:22:18 INFO - [mozharness: 2017-05-04 18:22:18.886888Z] Running clobber step. 11:22:18 INFO - Running pre-action listener: _resource_record_pre_action 11:22:18 INFO - Running main action method: clobber 11:22:18 INFO - rmtree: /builds/slave/test/build 11:22:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:20 INFO - Running post-action listener: _resource_record_post_action 11:22:20 INFO - [mozharness: 2017-05-04 18:22:20.649331Z] Finished clobber step (success) 11:22:20 INFO - [mozharness: 2017-05-04 18:22:20.649467Z] Running read-buildbot-config step. 11:22:20 INFO - Running pre-action listener: _resource_record_pre_action 11:22:20 INFO - Running main action method: read_buildbot_config 11:22:20 INFO - Using buildbot properties: 11:22:20 INFO - { 11:22:20 INFO - "project": "", 11:22:20 INFO - "product": "firefox", 11:22:20 INFO - "script_repo_revision": "production", 11:22:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:22:20 INFO - "repository": "", 11:22:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:22:20 INFO - "buildid": "20170504095619", 11:22:20 INFO - "pgo_build": "False", 11:22:20 INFO - "basedir": "/builds/slave/test", 11:22:20 INFO - "buildnumber": 2, 11:22:20 INFO - "slavename": "t-yosemite-r7-0185", 11:22:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:22:20 INFO - "platform": "yosemite_r7", 11:22:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:22:20 INFO - "branch": "mozilla-beta", 11:22:20 INFO - "repo_path": "releases/mozilla-beta", 11:22:20 INFO - "revision": "d92d578f631e730dd9c1f1725d2ee81ccb3ed8de", 11:22:20 INFO - "stage_platform": "macosx64", 11:22:20 INFO - "builduid": "f63e2a2a030245a595809f5819453b9a", 11:22:20 INFO - "slavebuilddir": "test" 11:22:20 INFO - } 11:22:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:22:20 INFO - Running post-action listener: _resource_record_post_action 11:22:20 INFO - [mozharness: 2017-05-04 18:22:20.652700Z] Finished read-buildbot-config step (success) 11:22:20 INFO - [mozharness: 2017-05-04 18:22:20.652818Z] Running download-and-extract step. 11:22:20 INFO - Running pre-action listener: _resource_record_pre_action 11:22:20 INFO - Running main action method: download_and_extract 11:22:20 INFO - mkdir: /builds/slave/test/build/tests 11:22:20 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')]} 11:22:20 INFO - trying https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:22:20 INFO - Downloading https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 11:22:21 INFO - Downloaded 1287 bytes. 11:22:21 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:22:21 INFO - Using the following test package requirements: 11:22:21 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 11:22:21 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:22:21 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:22:21 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:22:21 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:22:21 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:22:21 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:22:21 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:22:21 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:22:21 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:22:21 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:22:21 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:22:21 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:22:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:22:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:22:21 INFO - Fetch https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:22:23 INFO - Expected file size: 51226929 11:22:23 INFO - Obtained file size: 51226929 11:22:39 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:22:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:22:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:22:39 INFO - Fetch https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:22:41 INFO - Expected file size: 51226929 11:22:41 INFO - Obtained file size: 51226929 11:22:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:22:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:22:56 INFO - Fetch https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:22:58 INFO - Expected file size: 14404449 11:22:58 INFO - Obtained file size: 14404449 11:22: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')]} 11:22:58 INFO - trying https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:22:58 INFO - Downloading https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 11:23:00 INFO - Downloaded 59561410 bytes. 11:23:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:23:00 INFO - mkdir: /builds/slave/test/properties 11:23:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:00 INFO - Contents: 11:23:00 INFO - build_url:https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:23:00 INFO - Running post-action listener: _resource_record_post_action 11:23:00 INFO - Running post-action listener: set_extra_try_arguments 11:23:00 INFO - [mozharness: 2017-05-04 18:23:00.902166Z] Finished download-and-extract step (success) 11:23:00 INFO - [mozharness: 2017-05-04 18:23:00.902259Z] Running populate-webroot step. 11:23:00 INFO - Running pre-action listener: _resource_record_pre_action 11:23:00 INFO - Running main action method: populate_webroot 11:23:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:00 INFO - '--tppagecycles', 11:23:00 INFO - '7'], 11:23:00 INFO - 'tests': ['tsvgm']}}, 11:23:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['damp', 'tps']}, 11:23:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'tests': ['damp', 'tps']}, 11:23:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['dromaeo_dom']}, 11:23:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['basic_compositor_video']}, 11:23:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:23:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['a11yr', 11:23:00 INFO - 'ts_paint', 11:23:00 INFO - 'tpaint', 11:23:00 INFO - 'sessionrestore', 11:23:00 INFO - 'sessionrestore_no_auto_restore', 11:23:00 INFO - 'tabpaint']}, 11:23:00 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:00 INFO - 'ts_paint', 11:23:00 INFO - 'tpaint', 11:23:00 INFO - 'sessionrestore', 11:23:00 INFO - 'sessionrestore_no_auto_restore', 11:23:00 INFO - 'tabpaint']}, 11:23:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:00 INFO - 'ts_paint', 11:23:00 INFO - 'tpaint', 11:23:00 INFO - 'sessionrestore', 11:23:00 INFO - 'sessionrestore_no_auto_restore', 11:23:00 INFO - 'tabpaint']}, 11:23:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:00 INFO - 'ts_paint', 11:23:00 INFO - 'tpaint', 11:23:00 INFO - 'sessionrestore', 11:23:00 INFO - 'sessionrestore_no_auto_restore', 11:23:00 INFO - 'tabpaint']}, 11:23:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['a11yr', 11:23:00 INFO - 'ts_paint', 11:23:00 INFO - 'tpaint', 11:23:00 INFO - 'sessionrestore', 11:23:00 INFO - 'sessionrestore_no_auto_restore', 11:23:00 INFO - 'tabpaint']}, 11:23:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['a11yr', 11:23:00 INFO - 'ts_paint', 11:23:00 INFO - 'tpaint', 11:23:00 INFO - 'sessionrestore', 11:23:00 INFO - 'sessionrestore_no_auto_restore', 11:23:00 INFO - 'tabpaint']}, 11:23:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['tsvgx', 11:23:00 INFO - 'tsvgr_opacity', 11:23:00 INFO - 'tart', 11:23:00 INFO - 'tscrollx', 11:23:00 INFO - 'cart', 11:23:00 INFO - 'tsvg_static']}, 11:23:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:00 INFO - 'tsvgr_opacity', 11:23:00 INFO - 'tart', 11:23:00 INFO - 'tscrollx', 11:23:00 INFO - 'cart', 11:23:00 INFO - 'tsvg_static']}, 11:23:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'talos_options': ['--disable-e10s'], 11:23:00 INFO - 'tests': ['tp5o']}, 11:23:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:23:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'talos_options': ['--disable-e10s', 11:23:00 INFO - '--xperf_path', 11:23:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:00 INFO - 'tests': ['tp5n']}, 11:23:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:23:00 INFO - 'talos_options': ['--xperf_path', 11:23:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:00 INFO - 'tests': ['tp5n']}}, 11:23:00 INFO - 'talos.zip': {'path': '', 11:23:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:00 INFO - Running post-action listener: _resource_record_post_action 11:23:00 INFO - [mozharness: 2017-05-04 18:23:00.920540Z] Finished populate-webroot step (success) 11:23:00 INFO - [mozharness: 2017-05-04 18:23:00.920640Z] Running create-virtualenv step. 11:23:00 INFO - Running pre-action listener: _resource_record_pre_action 11:23:00 INFO - Running main action method: create_virtualenv 11:23:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:00 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 11:23:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:01 INFO - Using real prefix '/tools/python27' 11:23:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:23:01 INFO - Installing distribute.............................................................................................................................................................................................done. 11:23:04 INFO - Installing pip.................done. 11:23:04 INFO - Return code: 0 11:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:23:04 INFO - Reading from file tmpfile_stdout 11:23:04 INFO - Output received: 11:23:04 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) 11:23:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:04 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:04 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 11:23:04 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 11:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:04 INFO - 'HOME': '/Users/cltbld', 11:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:04 INFO - 'LOGNAME': 'cltbld', 11:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:04 INFO - 'MOZ_NO_REMOTE': '1', 11:23:04 INFO - 'NO_EM_RESTART': '1', 11:23:04 INFO - 'PAGER': '/bin/cat', 11:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:04 INFO - 'PWD': '/builds/slave/test', 11:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:04 INFO - 'SHELL': '/bin/bash', 11:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:04 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:04 INFO - 'USER': 'cltbld', 11:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:04 INFO - 'XPC_FLAGS': '0x0', 11:23:04 INFO - 'XPC_SERVICE_NAME': '0', 11:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:05 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 11:23:05 INFO - Cleaning up... 11:23:05 INFO - Return code: 0 11:23:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:23:05 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')]} 11:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:05 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')]} 11:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:05 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:05 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 11:23:05 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 11:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:05 INFO - 'HOME': '/Users/cltbld', 11:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:05 INFO - 'LOGNAME': 'cltbld', 11:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:05 INFO - 'MOZ_NO_REMOTE': '1', 11:23:05 INFO - 'NO_EM_RESTART': '1', 11:23:05 INFO - 'PAGER': '/bin/cat', 11:23:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:05 INFO - 'PWD': '/builds/slave/test', 11:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:05 INFO - 'SHELL': '/bin/bash', 11:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:05 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:05 INFO - 'USER': 'cltbld', 11:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:05 INFO - 'XPC_FLAGS': '0x0', 11:23:05 INFO - 'XPC_SERVICE_NAME': '0', 11:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:05 INFO - Downloading/unpacking psutil>=3.1.1 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:07 INFO - Installing collected packages: psutil 11:23:07 INFO - Running setup.py install for psutil 11:23:07 INFO - building 'psutil._psutil_osx' extension 11:23:07 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 11:23:08 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 11:23:08 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 11:23:08 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 11:23:08 INFO - building 'psutil._psutil_posix' extension 11:23:08 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 11:23:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:23:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:23:08 INFO - ^ 11:23:08 INFO - 1 warning generated. 11:23:08 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 11:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:08 INFO - Successfully installed psutil 11:23:08 INFO - Cleaning up... 11:23:08 INFO - Return code: 0 11:23:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:08 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')]} 11:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:08 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')]} 11:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:08 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:08 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 11:23:08 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 11:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:08 INFO - 'HOME': '/Users/cltbld', 11:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:08 INFO - 'LOGNAME': 'cltbld', 11:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:08 INFO - 'MOZ_NO_REMOTE': '1', 11:23:08 INFO - 'NO_EM_RESTART': '1', 11:23:08 INFO - 'PAGER': '/bin/cat', 11:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:08 INFO - 'PWD': '/builds/slave/test', 11:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:08 INFO - 'SHELL': '/bin/bash', 11:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:08 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:08 INFO - 'USER': 'cltbld', 11:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:08 INFO - 'XPC_FLAGS': '0x0', 11:23:08 INFO - 'XPC_SERVICE_NAME': '0', 11:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23:09 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 11:23:09 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 11:23:09 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 11:23:09 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 11:23:09 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 11:23:09 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 11:23:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:10 INFO - Installing collected packages: mozsystemmonitor 11:23:10 INFO - Running setup.py install for mozsystemmonitor 11:23:10 INFO - Successfully installed mozsystemmonitor 11:23:10 INFO - Cleaning up... 11:23:11 INFO - Return code: 0 11:23:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:23:11 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')]} 11:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:11 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')]} 11:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:11 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:11 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 11:23:11 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 11:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:11 INFO - 'HOME': '/Users/cltbld', 11:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:11 INFO - 'LOGNAME': 'cltbld', 11:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:11 INFO - 'MOZ_NO_REMOTE': '1', 11:23:11 INFO - 'NO_EM_RESTART': '1', 11:23:11 INFO - 'PAGER': '/bin/cat', 11:23:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:11 INFO - 'PWD': '/builds/slave/test', 11:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:11 INFO - 'SHELL': '/bin/bash', 11:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:11 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:11 INFO - 'USER': 'cltbld', 11:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:11 INFO - 'XPC_FLAGS': '0x0', 11:23:11 INFO - 'XPC_SERVICE_NAME': '0', 11:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:11 INFO - Downloading/unpacking jsonschema==2.5.1 11:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:23:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 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 11:23:12 INFO - Downloading functools32-3.2.3-2.tar.gz 11:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:23:13 INFO - warning: no files found matching '*.txt' 11:23:13 INFO - no previously-included directories found matching 'build' 11:23:13 INFO - no previously-included directories found matching 'dist' 11:23:13 INFO - no previously-included directories found matching '.git*' 11:23:13 INFO - Installing collected packages: jsonschema, functools32 11:23:13 INFO - Running setup.py install for functools32 11:23:13 INFO - warning: no files found matching '*.txt' 11:23:13 INFO - no previously-included directories found matching 'build' 11:23:13 INFO - no previously-included directories found matching 'dist' 11:23:13 INFO - no previously-included directories found matching '.git*' 11:23:13 INFO - Successfully installed jsonschema functools32 11:23:13 INFO - Cleaning up... 11:23:13 INFO - Return code: 0 11:23:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:23:13 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')]} 11:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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')]} 11:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:13 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 11:23:13 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 11:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:13 INFO - 'HOME': '/Users/cltbld', 11:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:13 INFO - 'LOGNAME': 'cltbld', 11:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:13 INFO - 'MOZ_NO_REMOTE': '1', 11:23:13 INFO - 'NO_EM_RESTART': '1', 11:23:13 INFO - 'PAGER': '/bin/cat', 11:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:13 INFO - 'PWD': '/builds/slave/test', 11:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:13 INFO - 'SHELL': '/bin/bash', 11:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:13 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:13 INFO - 'USER': 'cltbld', 11:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:13 INFO - 'XPC_FLAGS': '0x0', 11:23:13 INFO - 'XPC_SERVICE_NAME': '0', 11:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:23:13 INFO - Cleaning up... 11:23:13 INFO - Return code: 0 11:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:23:13 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')]} 11:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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')]} 11:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:13 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 11:23:13 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 11:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:13 INFO - 'HOME': '/Users/cltbld', 11:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:13 INFO - 'LOGNAME': 'cltbld', 11:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:13 INFO - 'MOZ_NO_REMOTE': '1', 11:23:13 INFO - 'NO_EM_RESTART': '1', 11:23:13 INFO - 'PAGER': '/bin/cat', 11:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:13 INFO - 'PWD': '/builds/slave/test', 11:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:13 INFO - 'SHELL': '/bin/bash', 11:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:13 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:13 INFO - 'USER': 'cltbld', 11:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:13 INFO - 'XPC_FLAGS': '0x0', 11:23:13 INFO - 'XPC_SERVICE_NAME': '0', 11:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 11:23:13 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 11:23:13 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 11:23:13 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 11:23:13 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 11:23:13 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 11:23:13 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 11:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz 11:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:23:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:23:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:16 INFO - Downloading docopt-0.6.1.tar.gz 11:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:23:16 INFO - Running setup.py install for blobuploader 11:23:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:23:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:23:16 INFO - Running setup.py install for requests 11:23:16 INFO - Running setup.py install for docopt 11:23:16 INFO - Successfully installed blobuploader requests docopt 11:23:16 INFO - Cleaning up... 11:23:16 INFO - Return code: 0 11:23:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:16 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:16 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 11:23:16 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 11:23:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:16 INFO - 'HOME': '/Users/cltbld', 11:23:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:16 INFO - 'LOGNAME': 'cltbld', 11:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:16 INFO - 'MOZ_NO_REMOTE': '1', 11:23:16 INFO - 'NO_EM_RESTART': '1', 11:23:16 INFO - 'PAGER': '/bin/cat', 11:23:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:16 INFO - 'PWD': '/builds/slave/test', 11:23:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:16 INFO - 'SHELL': '/bin/bash', 11:23:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:16 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:16 INFO - 'USER': 'cltbld', 11:23:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:16 INFO - 'XPC_FLAGS': '0x0', 11:23:16 INFO - 'XPC_SERVICE_NAME': '0', 11:23:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-HzyiC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-DepBol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-xgbvk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-VrXU3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-BT_E0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9_u7Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Kea_68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:17 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-AGW9j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-WFukDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ekt6zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-yWpDQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-VBExoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-SPssd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9a4fJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-XVc_XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-wkpCtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:18 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-K11NTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:19 INFO - Running setup.py install for manifestparser 11:23:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:19 INFO - Running setup.py install for mozcrash 11:23:19 INFO - Running setup.py install for mozdebug 11:23:19 INFO - Running setup.py install for mozdevice 11:23:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:19 INFO - Running setup.py install for mozfile 11:23:19 INFO - Running setup.py install for mozhttpd 11:23:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:19 INFO - Running setup.py install for mozinfo 11:23:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Running setup.py install for mozInstall 11:23:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Running setup.py install for mozleak 11:23:20 INFO - Running setup.py install for mozlog 11:23:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Running setup.py install for moznetwork 11:23:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Running setup.py install for mozprocess 11:23:20 INFO - Running setup.py install for mozprofile 11:23:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:20 INFO - Running setup.py install for mozrunner 11:23:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:21 INFO - Running setup.py install for mozscreenshot 11:23:21 INFO - Running setup.py install for moztest 11:23:21 INFO - Running setup.py install for mozversion 11:23:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:21 INFO - Cleaning up... 11:23:21 INFO - Return code: 0 11:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:21 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')]} 11:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:21 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')]} 11:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:21 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:21 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 11:23:21 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 11:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:21 INFO - 'HOME': '/Users/cltbld', 11:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:21 INFO - 'LOGNAME': 'cltbld', 11:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:21 INFO - 'MOZ_NO_REMOTE': '1', 11:23:21 INFO - 'NO_EM_RESTART': '1', 11:23:21 INFO - 'PAGER': '/bin/cat', 11:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:21 INFO - 'PWD': '/builds/slave/test', 11:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:21 INFO - 'SHELL': '/bin/bash', 11:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:21 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:21 INFO - 'USER': 'cltbld', 11:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:21 INFO - 'XPC_FLAGS': '0x0', 11:23:21 INFO - 'XPC_SERVICE_NAME': '0', 11:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:21 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-WcvFfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:21 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)) 11:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:21 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-0cethc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ny5QKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-7OrvkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ISyc0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-_1BCUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-JMOqeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-sBFRsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-33ERu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-quAcmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:22 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)) 11:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-97lWeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:23 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)) 11:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-z1Ie9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:23 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)) 11:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-2_gpzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:23 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)) 11:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-yCBhXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:23 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)) 11:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-8wtQU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:23 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)) 11:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-96nan8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:23 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)) 11:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rR8NMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:23 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)) 11:23:23 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)) 11:23:23 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)) 11:23:23 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)) 11:23:23 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)) 11:23:23 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)) 11:23:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23:23 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 11:23:23 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 11:23:23 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 11:23:23 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 11:23:23 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 11:23:23 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 11:23:25 INFO - Downloading blessings-1.6.tar.gz 11:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:25 INFO - Installing collected packages: blessings 11:23:25 INFO - Running setup.py install for blessings 11:23:25 INFO - Successfully installed blessings 11:23:25 INFO - Cleaning up... 11:23:25 INFO - Return code: 0 11:23:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:25 INFO - Reading from file tmpfile_stdout 11:23:25 INFO - Current package versions: 11:23:25 INFO - blessings == 1.6 11:23:25 INFO - blobuploader == 1.2.4 11:23:25 INFO - docopt == 0.6.1 11:23:25 INFO - functools32 == 3.2.3-2 11:23:25 INFO - jsonschema == 2.5.1 11:23:25 INFO - manifestparser == 1.1 11:23:25 INFO - mozInstall == 1.12 11:23:25 INFO - mozcrash == 1.0 11:23:25 INFO - mozdebug == 0.1 11:23:25 INFO - mozdevice == 0.49 11:23:25 INFO - mozfile == 1.2 11:23:25 INFO - mozhttpd == 0.7 11:23:25 INFO - mozinfo == 0.9 11:23:25 INFO - mozleak == 0.1 11:23:25 INFO - mozlog == 3.4 11:23:25 INFO - moznetwork == 0.27 11:23:25 INFO - mozprocess == 0.25 11:23:25 INFO - mozprofile == 0.28 11:23:25 INFO - mozrunner == 6.13 11:23:25 INFO - mozscreenshot == 0.1 11:23:25 INFO - mozsystemmonitor == 0.3 11:23:25 INFO - moztest == 0.8 11:23:25 INFO - mozversion == 1.4 11:23:25 INFO - psutil == 3.1.1 11:23:25 INFO - requests == 1.2.3 11:23:25 INFO - wsgiref == 0.1.2 11:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:25 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')]} 11:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:25 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')]} 11:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:25 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 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:25 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 11:23:25 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 11:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:25 INFO - 'HOME': '/Users/cltbld', 11:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:25 INFO - 'LOGNAME': 'cltbld', 11:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:25 INFO - 'MOZ_NO_REMOTE': '1', 11:23:25 INFO - 'NO_EM_RESTART': '1', 11:23:25 INFO - 'PAGER': '/bin/cat', 11:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:25 INFO - 'PWD': '/builds/slave/test', 11:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:25 INFO - 'SHELL': '/bin/bash', 11:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:25 INFO - 'USER': 'cltbld', 11:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:25 INFO - 'XPC_FLAGS': '0x0', 11:23:25 INFO - 'XPC_SERVICE_NAME': '0', 11:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 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)) 11:23:25 INFO - Cleaning up... 11:23:25 INFO - Return code: 0 11:23:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:25 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')]} 11:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:25 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')]} 11:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102831b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102834768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cfbcda000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, '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.TQdPHDeTKO/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.ipVsnSotlY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 11:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:25 INFO - 'HOME': '/Users/cltbld', 11:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:25 INFO - 'LOGNAME': 'cltbld', 11:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:25 INFO - 'MOZ_NO_REMOTE': '1', 11:23:25 INFO - 'NO_EM_RESTART': '1', 11:23:25 INFO - 'PAGER': '/bin/cat', 11:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:25 INFO - 'PWD': '/builds/slave/test', 11:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:25 INFO - 'SHELL': '/bin/bash', 11:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:25 INFO - 'USER': 'cltbld', 11:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:25 INFO - 'XPC_FLAGS': '0x0', 11:23:25 INFO - 'XPC_SERVICE_NAME': '0', 11:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:23:26 INFO - Cleaning up... 11:23:26 INFO - Return code: 0 11:23:26 INFO - Running post-action listener: _resource_record_post_action 11:23:26 INFO - Running post-action listener: _start_resource_monitoring 11:23:26 INFO - Starting resource monitoring. 11:23:26 INFO - [mozharness: 2017-05-04 18:23:26.218213Z] Finished create-virtualenv step (success) 11:23:26 INFO - [mozharness: 2017-05-04 18:23:26.219182Z] Running install step. 11:23:26 INFO - Running pre-action listener: _resource_record_pre_action 11:23:26 INFO - Running main action method: install 11:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:26 INFO - Reading from file tmpfile_stdout 11:23:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:26 INFO - Reading from file tmpfile_stdout 11:23:26 INFO - Output received: 11:23:26 INFO - Usage: mozinstall [options] installer 11:23:26 INFO - Options: 11:23:26 INFO - -h, --help show this help message and exit 11:23:26 INFO - -d DEST, --destination=DEST 11:23:26 INFO - Directory to install application into. [default: 11:23:26 INFO - "/builds/slave/test"] 11:23:26 INFO - --app=APP Application being installed. [default: firefox] 11:23:26 INFO - mkdir: /builds/slave/test/build/application 11:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:23:41 INFO - Reading from file tmpfile_stdout 11:23:41 INFO - Output received: 11:23:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:23:41 INFO - Running post-action listener: _resource_record_post_action 11:23:41 INFO - [mozharness: 2017-05-04 18:23:41.482501Z] Finished install step (success) 11:23:41 INFO - [mozharness: 2017-05-04 18:23:41.482618Z] Running run-tests step. 11:23:41 INFO - Running pre-action listener: _resource_record_pre_action 11:23:41 INFO - Running main action method: run_tests 11:23:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:23:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:23:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:23:41 INFO - 2017-05-04 11:23:41.497 screenresolution[2343:31537] starting screenresolution argv=screenresolution get 11:23:41 INFO - 2017-05-04 11:23:41.500 screenresolution[2343:31537] Display 0: 1600x1200x32@60 11:23:41 INFO - 2017-05-04 11:23:41.506 screenresolution[2344:31539] starting screenresolution argv=screenresolution list 11:23:41 INFO - Available Modes on Display 0 11:23:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:23:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:23:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:23:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:23:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:23:41 INFO - Intel Iris: 11:23:41 INFO - Chipset Model: Intel Iris 11:23:41 INFO - Type: GPU 11:23:41 INFO - Bus: Built-In 11:23:41 INFO - VRAM (Dynamic, Max): 1536 MB 11:23:41 INFO - Vendor: Intel (0x8086) 11:23:41 INFO - Device ID: 0x0a2e 11:23:41 INFO - Revision ID: 0x0009 11:23:41 INFO - Displays: 11:23:41 INFO - Display: 11:23:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:23:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:23:41 INFO - Display Serial Number: 1600x1200 60 11:23:41 INFO - Main Display: Yes 11:23:41 INFO - Mirror: Off 11:23:41 INFO - Online: Yes 11:23:41 INFO - Rotation: Supported 11:23:41 INFO - Return code: 0 11:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:41 INFO - Python 2.7.3 11:23:41 INFO - Return code: 0 11:23:41 INFO - grabbing minidump binary from tooltool 11:23:41 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')]} 11:23:41 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 0x10260fd30>, '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 0x102536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:41 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 11:23:41 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 11:23:41 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 11:23:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:41 INFO - Return code: 0 11:23:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:23:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:41 INFO - ENV: RUST_BACKTRACE is now 1 11:23:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:23:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 11:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --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 11:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQdPHDeTKO/Render', 11:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:41 INFO - 'HOME': '/Users/cltbld', 11:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:41 INFO - 'LOGNAME': 'cltbld', 11:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:41 INFO - 'MOZ_NO_REMOTE': '1', 11:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:41 INFO - 'NO_EM_RESTART': '1', 11:23:41 INFO - 'PAGER': '/bin/cat', 11:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:41 INFO - 'PWD': '/builds/slave/test', 11:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:41 INFO - 'RUST_BACKTRACE': '1', 11:23:41 INFO - 'SHELL': '/bin/bash', 11:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ipVsnSotlY/Listeners', 11:23:41 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 11:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:41 INFO - 'USER': 'cltbld', 11:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:41 INFO - 'XPC_FLAGS': '0x0', 11:23:41 INFO - 'XPC_SERVICE_NAME': '0', 11:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 11:23:42 INFO - mozversion application_buildid: 20170504095619 11:23:42 INFO - mozversion application_changeset: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de 11:23:42 INFO - mozversion application_display_name: Firefox 11:23:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:42 INFO - mozversion application_name: Firefox 11:23:42 INFO - mozversion application_remotingname: firefox 11:23:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:23:42 INFO - mozversion application_vendor: Mozilla 11:23:42 INFO - mozversion application_version: 54.0 11:23:42 INFO - mozversion platform_buildid: 20170504095619 11:23:42 INFO - mozversion platform_changeset: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de 11:23:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:23:42 INFO - mozversion platform_version: 54.0 11:23:42 INFO - using testdate: 1493922222 11:23:42 INFO - actual date: 1493922222 11:23:42 INFO - starting webserver on 'localhost:58826' 11:23:42 INFO - SUITE-START | Running 2 tests 11:23:42 INFO - TEST-START | dromaeo_css 11:23:42 INFO - operating with platform_type : mac_ 11:23:42 INFO - Initialising browser for dromaeo_css test... 11:23:42 INFO - TEST-INFO | started process 2354 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpd1_3Ou/profile http://localhost:58826/getInfo.html) 11:23:44 INFO - PROCESS | 2354 | __metrics Screen width/height:1600/1200 11:23:44 INFO - PROCESS | 2354 | colorDepth:24 11:23:44 INFO - PROCESS | 2354 | Browser inner width/height: 1024/689 11:23:44 INFO - PROCESS | 2354 | __metrics 11:23:44 INFO - PROCESS | 2354 | 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" 11:23:44 INFO - PROCESS | 2354 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:45 INFO - TEST-INFO | 2354: exit 0 11:23:45 INFO - Browser initialized. 11:23:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:45 INFO - TEST-INFO | started process 2357 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpd1_3Ou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:57 INFO - PROCESS | 2357 | RSS: Main: 165101568 11:23:57 INFO - PROCESS | 2357 | 11:27:01 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58826/tests/dromaeo/cssquery-ext.html) 11:27:03 INFO - PROCESS | 2357 | RSS: Main: 296935424 11:27:03 INFO - PROCESS | 2357 | 11:30:06 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-ext.html (next: http://localhost:58826/tests/dromaeo/cssquery-jquery.html) 11:30:06 INFO - PROCESS | 2357 | RSS: Main: 301858816 11:30:06 INFO - PROCESS | 2357 | 11:33:09 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58826/tests/dromaeo/cssquery-mootools.html) 11:33:09 INFO - PROCESS | 2357 | RSS: Main: 288112640 11:33:09 INFO - PROCESS | 2357 | 11:36:12 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58826/tests/dromaeo/cssquery-prototype.html) 11:36:12 INFO - PROCESS | 2357 | RSS: Main: 268623872 11:36:12 INFO - PROCESS | 2357 | 11:39:16 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58826/tests/dromaeo/cssquery-yui.html) 11:39:17 INFO - PROCESS | 2357 | RSS: Main: 267333632 11:39:17 INFO - PROCESS | 2357 | 11:42:20 INFO - PROCESS | 2357 | Cycle 1(1): loaded http://localhost:58826/tests/dromaeo/cssquery-yui.html (next: http://localhost:58826/tests/dromaeo/cssquery-dojo.html) 11:42:21 INFO - PROCESS | 2357 | RSS: Main: 317837312 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | __start_tp_report 11:42:21 INFO - PROCESS | 2357 | _x_x_mozilla_page_load 11:42:21 INFO - PROCESS | 2357 | _x_x_mozilla_page_load_details 11:42:21 INFO - PROCESS | 2357 | |i|pagename|runs| 11:42:21 INFO - PROCESS | 2357 | |0;dojo.html;2951.5425109108082;3352.296017836254;3508.4561892906577;3511.2275299434114;3527.982360088199;6022.066579680151;6089.421504957022;6107.38926107389;6134.969325153379;6165.260168779747;6100.603460775046;6127.693615319238;6170.660613666258;6178.227721534809;6203.162573052637;5396.91904621431;5424.294841670578;5459.208414779854;5465.890682186354;5537.778488860461;5330.440303768107;5335.146376579748;5337.759800808973;5501.862453438656;5560.805371811967;5406.405295417501;5427.945720542783;5432.809851655193;5439.782408703667;5440.129579267318;5418.620696551243;5423.186522021689;5424.593155513333;5426.647267927572;5428.4028756836915;5255.894882102375;5385.4883786040655;5387.703676297802;5398;5425.02349577076;6096.466212027279;6096.889554637394;6098.704546243851;6107.461915314337;6130.367562715059;6330.430261276461;6361.936380636181;6373.490120790326;6376.968115159394;6389.8402539936405;5603.523700485463;6484.286728459866;6577.769778057793;6582.275949645536;6586.407223349922;5210.817621383271;5273.3935597406025;5543.722813859291;6244.6253224806205;6272.090546870678;6523.967380163069;6525.738970441224;6573.605583664996;6595.8351041223395;6603.504737144734;6377.553571249968;6383.425491705769;6386.680665966683;6389.616623002635;6414.973604223302;6566.3105373936005;6582.506312026617;6587.110740050032;6589.275179730226;6591.6374599397495;6206.937930620636;6265;6359.459445947146;6375.458086062644;6490.188726409199;6472.35276472349;6491.902621460682;6493.350664933469;6503;6533.41199292066;5233.1365324721755;5249.2126181073145;5271.525562699376;5275.60432967529;5304.681719096867;4600.309953506934;4605.470370907322;4605.861824145281;4619.838305659353;4698.530146985342;6146;6194.721237544231;6221.377862213742;6223.719932603044;6229.034499652561;6602.86794264112;6607.76872809459;6616.007598860209;6624.436922861611;6646.6676666166495;6210.937890621036;6221.253449586078;6244.406781355764;6255.530835187288;6261.154744109578;5622.887542249132;5674.177244299553;5696.715164241771;5701.429857014348;5744.741486633112;6612.173478315211;6624.8343791405605;6635.270120286861;6636.170478690164;6664.700088496126;6416.903746443901;6443.09796628463;6452.451541619015;6457.192850893638;6500.28496865335;5462.426445223353;6839.658017099225;6843.110395648534;6861;6868.62222577763;6482.57863238888;6485.740570377321;6488.383603557654;6491.350864913471;6492.156019717407;6331.0819931110655;6373.776917807854;6472.0291956205065;6586.077949087035;6609.074729537965;6262.5929314594405;6360.300366959723;6402.007688808242;6427.325130861379;6432.903506447314;6410.711517981796;6415.1981002374705;6423.550351475352;6436.6459844707115;6439.291677915519;6196.535259855619;6222.066689996536;6283.994560870239;6301.149344838388;6314.179156709598;6329.620222786648;6407.391297826699;6425.678716064272;6441.935580644321;6446.355364463516;6294.968525157345;6295.685215739286;6305.211848518935;6305.4009869062365;6318.936810631835 11:42:21 INFO - PROCESS | 2357 | |1;ext.html;772.8067983004249;812.0012384766736;911.1435250864187;912.352229916759;989.154273096503;30311.696883031163;40468.59531404685;43196.56803431965;43206.135877282475;43268.56731432685;40977.795111024476;41356.379654305136;41375;41377.58622413775;41409.96475088124;7794.8441031179345;8089.312408445289;8241.175882411771;8242.958785206065;8260.339172866155;7880.330171935392;11641.18511704181;11875.821862672066;12173.087018473605;12181.57364492243;11892.583759568417;11929;11932.403379831017;11944.283342999404;11953.22304050234;11858.584949526768;11883.40582970848;11888.46501907412;11893.226940248942;11907;11447;11517.308961462339;11530.884691153065;11536.884631153665;11537.769244615061;40289.59710402917;40580;40631.59368406337;40647.7967610163;40698.77903662895;3941.7437866538585;4022.255882661688;4031.23406552754;4031.7984100794843;4041.2927737645796;28655.426891462263;28887.277818054506;30133.698663013307;31076.844615776776;31731.84134079338;3158.921026974344;3224.1456014156265;3298.307355455357;3373.241020770307;3405.2848901730667;321354;329337;330979;333181;333490;43238;43896.56103438925;52099.437016889555;52176.739116304176;52187.21719174215;47270.29094563585;58026;58063.70968145132;59038.70480647569;59039.704801476575;16002.839971600135;16072.437464688679;16080.919595401949;16095;16095.919520402556;13559.932200338935;13574.457021719021;13580.592582222549;13608.183508989492;13620.591382258548;13111.541096061783;13158.342082895817;13272.070955033249;13286.601401957956;13359.332033398292;5805.651660900359;5820.970895145582;5829.8251052468495;5839;5845.883082338414;1156.0462618339902;1161.4250945781891;1164.5400066973498;1169.9473523691454;1223.174357308813;19706.70439943402;26989.190324290303;27442.862785685942;27471;27529.86235068852;938.8075444533854;1172.9296242225494;1177.1877404590975;1217.8051511758254;1341.9597412077458;13755.862441375659;14024.929875350557;14070.507532236323;14220.431182752782;14311.499097531536;376468;490282.5485872548;495388;586347;587823;49979.000419992124;50149;50276.994460110596;50283.49716502861;50491.49508504941;1456.3664805809506;1486.799282096903;1495.9775603365958;1502.9549113526393;1507.547735679292;26457.33856653599;27643.447131056862;28087.0169544065;28236.71763282341;28242;33808.985730428125;41165.58834411618;41204.38193427161;41241.793791030854;41285.58714412938;468926;469859.30140698154;470089;470196;470873;24655.38361540976;24975.87608557583;29298.853505732335;31240.531392029592;31983.36033279368;41312;41520.546780862525;41975.7901210492;42051.15897681968;42596.78701606472;23141.88429057844;28590.857045714638;28688.569671455363;29349.853250734464;30302;29003.854980724962;29504.557431638113;29911.252218694706;30051.69948300489;30142.54786178165;34530.82734586311;35585.288294233455;35643.82178089093;35663.46504802482;35682.82158589294;26335;28497.860085597174;28531.14406567806;29101.12696619105;29708;22676.465629245715;23553.76446235584;23854;24187;24272 11:42:21 INFO - PROCESS | 2357 | |2;jquery.html;359.9830478897115;385.5277285325476;424.4630542363908;427.36322878910414;465.527489598058;18566.72149917752;20585.970701464925;21236.681449778265;22365.888170559123;22477.32568022958;19189.808101918978;23515.529689406245;23735;24265;24547.75452245477;6604.513984353518;6880.105586273802;6921.273266307041;6924;6928.168619765635;6439.452646525051;6768.052472653832;6836.521443498932;6847.520673552828;6854.862902741942;6524.771632992846;6796.660166991655;6816.897746533781;6833.487488438363;6844.110265665457;6792.490563207779;6843.863122737517;6846.212685541177;6848.554843935129;6897.137857767779;5616.887662246773;6222.96888515559;6578.342165783383;6578.440832529241;6581.506387020992;28457.857710711312;28459.71540284612;28470.861165553353;28472.7187276571;28503.429931401257;3017.517197248452;3025.909222723322;3035.893743718981;3068.2789544457037;3078.9993252192903;16674.49976500707;16877.240524176443;17016.744748828653;17106.401275955282;17281.654366912593;2062.6802845558964;2088.5300807318386;2092.5814837032503;2112.3134981131193;2129.1057755742627;122800;145582;146619;148628;148876.99999999892;21468.248611298528;21541;21545.56908861814;21684.24105156312;21781.346559603237;34468.65531344654;35094.9471515855;35156.824215878754;35324.47013294802;35334.46998295028;10929.508172132273;11257.043151332065;11419.885801142049;11429.885701143048;11624.302541847515;9280.535973201313;9300.302477314228;9309.16217540411;9528.571214295373;9537.2370210383;8200.917990820015;10190.694279171637;10235.948820255851;10246.743831404125;10347.120494757879;3193.7924034937655;4045.8988525287104;4179.540250572434;4258.339957306623;4262.296721041055;988.5996171550534;994.7562847102506;998.3610489286717;1034.6637342863598;1088.145805542661;22108.88945555262;23112.537749244922;23249.535009299718;23277.53444931092;23323.88338058299;1066.2589500297374;1070.47011729193;1090.1878100814943;1101.944902754859;1111.4220605285207;12013;12218.26690398579;12225.938870305592;12322.75354492923;12411.565595204125;685822;731931;732485;779763.1011844905;786010;131500;134845.3257733705;137149;138895;141889.29055354864;1267.467663581298;1284.6146156153118;1312.534050412109;1314.3165553911913;1316.5457917018614;19503;19616.509587260432;19912.800871991672;19941.105594968456;19972.70040949358;57062.42937570571;57473;58111.70944145252;59015;59031.70484147552;80237.19762802297;80795.19204807877;81123.78314325408;82967;83787;12078.282022651043;12184.634460966185;12330.938345308216;12563.560275390317;12651.557195498113;13587.660308492366;13673.24797136167;13707.451701931812;14105.576832695035;14134.646633834236;11678.88321116778;11970.76058478843;12045.217060891015;12197.75604487923;12244.632661020183;9877.753056173653;10598.417087059977;11181.161412894227;11183.496742646763;11648.708782280512;11586.478608462809;12061.51753929833;12112.636620901387;12196.963258123158;12246.265224086583;12100.697482563006;12122.757544848877;12293.44679489443;12304;12460.501579937063;10665.733356665834;11743.823842642538;11942.402879856147;12048;12079.75840483203 11:42:21 INFO - PROCESS | 2357 | |3;mootools.html;1463.7584798508246;1569.7802307676934;1605.165314036701;1630.1849075462264;1636.190085907476;10884.891151088486;11564.479598418071;11571.421428928552;11571.942140289297;11575.305481671106;11085.334879907192;11279.661610151688;11388;11627.941860290708;11635.767284654301;2450.4363996280867;2491.788198003172;2497.987510062447;2499.7750202481775;2508.2726009457238;2150.84929562684;2291.2897001929373;2414.4808866093786;2456.6192240202795;2468.7778099971;2385.6779334789753;2455.0670745116918;2465.938351541217;2466.519028789387;2475.1337032038823;2173.652215645505;2209.91714060111;2447.2780529743677;2456.4350199454225;2458.7172475165316;2447.0823441209545;2468.7160976487753;2471.159805666064;2472.666190064336;2476.4799392127675;11237.157213209042;11447.370394628291;11462.541498340057;11467.31196128235;11469.713257168554;5934.347221805598;6083.665398403086;6102.1151932969915;6103.359147289515;6141.508679305645;3600.7299452541165;3681.7975011374365;3692.649198326155;3752.2683076800035;3755.380362240227;1206.7707135644287;1229.0659099084671;1254.3540076860425;1268.9111762176651;1288.5618889577495;14042.1574705518;14322.785158222636;14664.853351466456;15795.921020394824;15948.441804536902;4095.4675892133832;4336.3278691802825;4393.29707246839;4455.086707225076;4885.682430642068;11999.820002699966;12001.759964800654;12033.217840840318;12035.097367697283;12048.457819398149;5978.611390259619;5990.371011043865;6003.5797494174985;6017.879642407127;6028.0355143176885;5174.482551744795;5391.191321301836;5439.401665816757;5489.862753431116;5495.148252020943;3922.9215415692097;3957.406389041609;4015.1768887378603;4020.2562525932794;4064.8170832312617;867.3798234262532;1026.573971801694;1045.7019749371545;1046.3774054437597;1047.7904419116207;963.2246041936309;1002.8997100289913;1006.3911333643186;1009.7374682582581;1039.3036665434176;6626.237982632059;6744.325567443217;6747.763828265987;6903.482238832108;6945;895.7044175422095;994.8656931314325;1022.3099407899638;1050.558765318568;1066.7919755647729;4120.62914337711;4163.916721665611;4166.229247589205;4177.728447650893;4224.260754367973;13382.799258011137;14089.15465072099;14104.012719109769;14115.294235288195;14119.85880141206;13900.16599004063;14002.57992260234;14024.368903399372;14033.508827191203;14064.945129115356;8483.406161568631;8850.690225842065;9145.81708365829;10284.485775711184;10290.228232882564;6056.3035250946705;6599.934000659932;6643.900341494785;6675.23234828001;7002.544834585736;11948.581799636971;12005;12020.939895300467;12083.697907552381;12341.75316493683;12334.938325308316;12739.426725797546;12741.936290318488;12744.808827867404;12798.872011279767;10427.426491542734;10469.68590942273;10622.681319560426;10660.200484963503;10706.785864282827;10243.282970192313;10601.893981060091;10606.681799546026;10607.098396636373;10633.787324253626;8619.1811777881;8742.694005709769;8764.693235736719;8853.601587928688;9092.045335239969;8567.700130495403;8675.956620217112;8742.038375778786;8787.780305492413;8812.339074569305;7925.881111783443;8026.59867006659;8050.83898322042;8056.879146812919;8096.39277054235;5286.286351342519;5905.261842269716;5996.760129594767;6068.302145253352;6229.626222426669;5964.582479226413;6090.482309003784;6159.599626024294;6223.502119830493;6419.45434638061 11:42:21 INFO - PROCESS | 2357 | |4;prototype.html;332.3535723018729;384.39649749892646;385.44495925866767;395.86540576204084;399.4288167919875;4843.297721830332;5050.29295898574;5072.9492705072935;5118.462561431043;5201.531862132408;3865.6083809828438;4274.337477690963;4341.956580434195;4973.52751488608;5043.646944713872;3169.603799525065;3355.832208389583;3493.982530087346;3920.9607903920883;3960.4950118954903;3385.628820327759;3667.7529639922554;3925.862594809182;3959.485266915297;3960.4059391091278;3360.9159771005798;3760.2667479841443;3974.4237085622567;3984.262911361393;4000.8399664013405;3907.5310962684375;3983.6414722674954;4000.339943909266;4143.233501802176;4200.894977625584;3838.7120965927666;3853.8651147209994;3887.803391084057;3910.296146693594;3928.6464218220212;4172.728772629769;4391.802368893407;4479.372887795711;4872.853814385574;4993.252361673422;3842.385218365076;4163.834126444601;4338.631216346583;4595.885102872455;4644.489106198315;4617.568553748349;5337.919931201035;5356.785728570852;5382.4886635769535;5394.622376433651;4297.119090586453;4356.411884395598;4374.431323927869;4402.295632698753;4406.405135306757;4670.579647831712;5341.679499230058;5404.891902161974;5600.243967064475;5823.5341172706085;3259.707695227837;4022.1352409232154;4394.8242070317465;4420.270655341897;4431.8448854289945;4518.367428560005;4537.3647689323525;4548.977255113703;4573.862784116415;4583.656225783079;4059.918801623951;4361.302191649384;4774.522547745267;4775.904481910412;4879.39007624047;4366.43236379275;4936.185529387682;5309.699123714715;5415.891682166334;5505.449455054542;1403.943842246319;1525.6262215756988;1578.5580037589493;1579.136618789816;1595.3060418717894;1023.2808881079858;1084.9620263290906;1088.9564417423373;1096.1066730614523;1166.731651720109;4606.677532572688;4770.570648641569;4963.808685915426;5087.448328259842;5264.42091369949;5061.519155680205;5413.105413105461;5706.857328566819;5746.42535746422;5758.280214973129;4627.444706635158;4652.418447694038;4832.975835120872;5085.542301192911;5171.974140129275;2581.457893842314;2606.387498937748;2624.9212523624324;2669.745219746716;2681.037453613768;5033.79864805411;5329.813456529003;5625.493705566437;5780.132980052942;5800.50695690871;5274;5347.3048503695045;5517.61376703635;5569.944300556943;5693.943060569424;4802.391198948251;5344.946550534522;5717.542596592346;5727.151550854024;5867.973104706659;4811.133995880775;5012.39355535127;5080.669756465966;5244.239585260192;5247.921281180862;4289.7640629765665;5361.651492652965;5504.504594586507;5510;5534.4742249486235;5400.324959380077;5797.434577734747;5827.484853937922;5847.473727364558;5855.94144058554;3832.9616703832603;3912.6087391260644;3982.3628219484744;4338.978305108454;4542.364069030405;4912.778924948458;5346.545543628835;5396.542933408036;5446.537044351275;5464.890702186013;4510.797014134438;5231.607629427732;5255.579553635776;5285;5364.731763411735;4739.819682945884;5125.948740512547;5386.976474469838;5387.299651045339;5400.513953744182;4676.929846052244;4735.810567577259;5052.635788337055;5161;5203.725204900866;4326.740395576276;5173.188934290995;5180.7150606717;5277.973610131925;5400;4480.507144214199;4619.769011549476;5168;5285.920711189258;5337.759800808895 11:42:21 INFO - PROCESS | 2357 | |5;yui.html;742.1168809117147;761.8438220164863;795.9363250939925;819.6188772220916;884.1423818895669;15787.052776833383;16588.419405320816;17581.03304318262;17589;17651.911740441297;14471.92764036181;16068;16079.035257884536;16213.189340532985;16262.593435164097;970.5001924009141;982.9852552211722;1009.8639031090024;1028.984565231522;1044.5560636729397;1020.8979102089805;1023.918086553074;1024.9795004099951;1026.0304012707993;1026.4405898785142;1079.8164312066967;1080.5461706083463;1082.1667316166547;1082.2262082610932;1083.544911137324;1074.3231763988715;1074.457399013501;1074.6668532754793;1077.154433769491;1077.4343469678404;684.3156843156843;797.9905419644155;798.0941631248575;799.4403917257943;800.4676889868231;15274.541763747106;16906.070166140857;17535.210915508833;17551.648967020716;17612.647747044986;14687.485937992118;14888.330025148894;14935.775963360558;14970.62573435662;15354;12078.637640870787;12150.45322960469;12283.263004219776;12369.196002259825;12393.194442361219;3853.2100919311474;3910.1295273813084;4007.3788562772816;4097.487814023247;4151.4395556599775;96294;99051.00948990561;105423.47288263586;107683;110214;11605.709857253636;11743.236689615147;11875;12190.878091219152;12370.13409061357;23213;23648.881755591457;23755.049798008233;23757.524849502912;23932.52134957291;8218.465799722999;8311.584420778936;8321.459105158145;8410.453320534145;8411.242988130974;4545.227311357011;4617.46899106607;4649.349091127245;4654.767261636905;4667.183242932473;3380.053584996205;3480.9731129316406;3484.4599087141532;3489.5638045244345;3490.9650903491147;596.4423264247943;605.748614325059;610.1549354144541;610.4079043327964;627.626562195493;686.0978062794408;702.3362922038624;709.1950636028146;752.1049950558818;766.3103207113643;10838.349699018085;10889.183311251687;10907.29102608328;11215.66353009411;11399;702.3924305475726;730.1384366447537;733.8458923625991;754.8754455514778;789.0886026639241;4951.975240123848;5216;5240.213611279005;5282.2340760589495;5291.603129765283;96706;97422.5128874351;98791;101911;102356.48821755992;94346;94559;96436.51781741047;96649.55025674621;96743;85273;86331.13668863356;86881.56559217164;87301.56349218213;89596.55201723949;9904.356216845881;10243.436610986468;10250.58997640086;10280.22898282617;10288.948555257175;56041;56521;56832;57149.71425142848;57464;58596.4140358608;62913.05630415456;65192.67403662951;72478.27521724926;73614.63192684003;13376.464941402235;13547.661308467366;13675.24786136772;13724.660269593176;14222.288885555889;15258.618534536725;15716.528504144893;15765.527034188992;16717.91641041787;16759.07825069633;11336.376499292619;14183.79437747803;14757.92621036888;14865.405383784528;15173.772393413887;14205.715885682435;14602.342894569558;14629.92685036568;15044.699106018037;15198.46805361807;13411.396487158296;13872.028957972845;13873.861261387257;14106.224157671426;14154.221517816619;10116.494175291353;10235.437050962268;10391.168706503311;10893.291936024134;11037.172212084286;11460.829791580458;11568.743503150668;11692.415379231175;11799.292042477478;11846.763064738829 11:42:21 INFO - PROCESS | 2357 | __end_tp_report 11:42:21 INFO - PROCESS | 2357 | __start_cc_report 11:42:21 INFO - PROCESS | 2357 | _x_x_mozilla_cycle_collect,1661 11:42:21 INFO - PROCESS | 2357 | __end_cc_report 11:42:21 INFO - PROCESS | 2357 | __startTimestamp1493923341126__endTimestamp 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | ------- Summary: start ------- 11:42:21 INFO - PROCESS | 2357 | Number of tests: 6 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | [#0] dojo.html Cycles:165 Average:6021.13 Median:6283.99 stddev:698.55 (11.1%) stddev-sans-first:657.88 11:42:21 INFO - PROCESS | 2357 | Values: 2951.5 3352.3 3508.5 3511.2 3528.0 6022.1 6089.4 6107.4 6135.0 6165.3 6100.6 6127.7 6170.7 6178.2 6203.2 5396.9 5424.3 5459.2 5465.9 5537.8 5330.4 5335.1 5337.8 5501.9 5560.8 5406.4 5427.9 5432.8 5439.8 5440.1 5418.6 5423.2 5424.6 5426.6 5428.4 5255.9 5385.5 5387.7 5398.0 5425.0 6096.5 6096.9 6098.7 6107.5 6130.4 6330.4 6361.9 6373.5 6377.0 6389.8 5603.5 6484.3 6577.8 6582.3 6586.4 5210.8 5273.4 5543.7 6244.6 6272.1 6524.0 6525.7 6573.6 6595.8 6603.5 6377.6 6383.4 6386.7 6389.6 6415.0 6566.3 6582.5 6587.1 6589.3 6591.6 6206.9 6265.0 6359.5 6375.5 6490.2 6472.4 6491.9 6493.4 6503.0 6533.4 5233.1 5249.2 5271.5 5275.6 5304.7 4600.3 4605.5 4605.9 4619.8 4698.5 6146.0 6194.7 6221.4 6223.7 6229.0 6602.9 6607.8 6616.0 6624.4 6646.7 6210.9 6221.3 6244.4 6255.5 6261.2 5622.9 5674.2 5696.7 5701.4 5744.7 6612.2 6624.8 6635.3 6636.2 6664.7 6416.9 6443.1 6452.5 6457.2 6500.3 5462.4 6839.7 6843.1 6861.0 6868.6 6482.6 6485.7 6488.4 6491.4 6492.2 6331.1 6373.8 6472.0 6586.1 6609.1 6262.6 6360.3 6402.0 6427.3 6432.9 6410.7 6415.2 6423.6 6436.6 6439.3 6196.5 6222.1 6284.0 6301.1 6314.2 6329.6 6407.4 6425.7 6441.9 6446.4 6295.0 6295.7 6305.2 6305.4 6318.9 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | [#1] ext.html Cycles:180 Average:57015.88 Median:31158.69 stddev:118336.72 (379.8%) stddev-sans-first:118593.34 11:42:21 INFO - PROCESS | 2357 | Values: 772.8 812.0 911.1 912.4 989.2 30311.7 40468.6 43196.6 43206.1 43268.6 40977.8 41356.4 41375.0 41377.6 41410.0 7794.8 8089.3 8241.2 8243.0 8260.3 7880.3 11641.2 11875.8 12173.1 12181.6 11892.6 11929.0 11932.4 11944.3 11953.2 11858.6 11883.4 11888.5 11893.2 11907.0 11447.0 11517.3 11530.9 11536.9 11537.8 40289.6 40580.0 40631.6 40647.8 40698.8 3941.7 4022.3 4031.2 4031.8 4041.3 28655.4 28887.3 30133.7 31076.8 31731.8 3158.9 3224.1 3298.3 3373.2 3405.3 321354.0 329337.0 330979.0 333181.0 333490.0 43238.0 43896.6 52099.4 52176.7 52187.2 47270.3 58026.0 58063.7 59038.7 59039.7 16002.8 16072.4 16080.9 16095.0 16095.9 13559.9 13574.5 13580.6 13608.2 13620.6 13111.5 13158.3 13272.1 13286.6 13359.3 5805.7 5821.0 5829.8 5839.0 5845.9 1156.0 1161.4 1164.5 1169.9 1223.2 19706.7 26989.2 27442.9 27471.0 27529.9 938.8 1172.9 1177.2 1217.8 1342.0 13755.9 14024.9 14070.5 14220.4 14311.5 376468.0 490282.5 495388.0 586347.0 587823.0 49979.0 50149.0 50277.0 50283.5 50491.5 1456.4 1486.8 1496.0 1503.0 1507.5 26457.3 27643.4 28087.0 28236.7 28242.0 33809.0 41165.6 41204.4 41241.8 41285.6 468926.0 469859.3 470089.0 470196.0 470873.0 24655.4 24975.9 29298.9 31240.5 31983.4 41312.0 41520.5 41975.8 42051.2 42596.8 23141.9 28590.9 28688.6 29349.9 30302.0 29003.9 29504.6 29911.3 30051.7 30142.5 34530.8 35585.3 35643.8 35663.5 35682.8 26335.0 28497.9 28531.1 29101.1 29708.0 22676.5 23553.8 23854.0 24187.0 24272.0 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | [#2] jquery.html Cycles:180 Average:42386.92 Median:21543.28 stddev:123348.41 (572.6%) stddev-sans-first:123654.07 11:42:21 INFO - PROCESS | 2357 | Values: 360.0 385.5 424.5 427.4 465.5 18566.7 20586.0 21236.7 22365.9 22477.3 19189.8 23515.5 23735.0 24265.0 24547.8 6604.5 6880.1 6921.3 6924.0 6928.2 6439.5 6768.1 6836.5 6847.5 6854.9 6524.8 6796.7 6816.9 6833.5 6844.1 6792.5 6843.9 6846.2 6848.6 6897.1 5616.9 6223.0 6578.3 6578.4 6581.5 28457.9 28459.7 28470.9 28472.7 28503.4 3017.5 3025.9 3035.9 3068.3 3079.0 16674.5 16877.2 17016.7 17106.4 17281.7 2062.7 2088.5 2092.6 2112.3 2129.1 122800.0 145582.0 146619.0 148628.0 148877.0 21468.2 21541.0 21545.6 21684.2 21781.3 34468.7 35094.9 35156.8 35324.5 35334.5 10929.5 11257.0 11419.9 11429.9 11624.3 9280.5 9300.3 9309.2 9528.6 9537.2 8200.9 10190.7 10235.9 10246.7 10347.1 3193.8 4045.9 4179.5 4258.3 4262.3 988.6 994.8 998.4 1034.7 1088.1 22108.9 23112.5 23249.5 23277.5 23323.9 1066.3 1070.5 1090.2 1101.9 1111.4 12013.0 12218.3 12225.9 12322.8 12411.6 685822.0 731931.0 732485.0 779763.1 786010.0 131500.0 134845.3 137149.0 138895.0 141889.3 1267.5 1284.6 1312.5 1314.3 1316.5 19503.0 19616.5 19912.8 19941.1 19972.7 57062.4 57473.0 58111.7 59015.0 59031.7 80237.2 80795.2 81123.8 82967.0 83787.0 12078.3 12184.6 12330.9 12563.6 12651.6 13587.7 13673.2 13707.5 14105.6 14134.6 11678.9 11970.8 12045.2 12197.8 12244.6 9877.8 10598.4 11181.2 11183.5 11648.7 11586.5 12061.5 12112.6 12197.0 12246.3 12100.7 12122.8 12293.4 12304.0 12460.5 10665.7 11743.8 11942.4 12048.0 12079.8 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | [#3] mootools.html Cycles:180 Average:6867.50 Median:2462.33 stddev:4288.27 (174.2%) stddev-sans-first:4281.07 11:42:21 INFO - PROCESS | 2357 | Values: 1463.8 1569.8 1605.2 1630.2 1636.2 10884.9 11564.5 11571.4 11571.9 11575.3 11085.3 11279.7 11388.0 11627.9 11635.8 2450.4 2491.8 2498.0 2499.8 2508.3 2150.8 2291.3 2414.5 2456.6 2468.8 2385.7 2455.1 2465.9 2466.5 2475.1 2173.7 2209.9 2447.3 2456.4 2458.7 2447.1 2468.7 2471.2 2472.7 2476.5 11237.2 11447.4 11462.5 11467.3 11469.7 5934.3 6083.7 6102.1 6103.4 6141.5 3600.7 3681.8 3692.6 3752.3 3755.4 1206.8 1229.1 1254.4 1268.9 1288.6 14042.2 14322.8 14664.9 15795.9 15948.4 4095.5 4336.3 4393.3 4455.1 4885.7 11999.8 12001.8 12033.2 12035.1 12048.5 5978.6 5990.4 6003.6 6017.9 6028.0 5174.5 5391.2 5439.4 5489.9 5495.1 3922.9 3957.4 4015.2 4020.3 4064.8 867.4 1026.6 1045.7 1046.4 1047.8 963.2 1002.9 1006.4 1009.7 1039.3 6626.2 6744.3 6747.8 6903.5 6945.0 895.7 994.9 1022.3 1050.6 1066.8 4120.6 4163.9 4166.2 4177.7 4224.3 13382.8 14089.2 14104.0 14115.3 14119.9 13900.2 14002.6 14024.4 14033.5 14064.9 8483.4 8850.7 9145.8 10284.5 10290.2 6056.3 6599.9 6643.9 6675.2 7002.5 11948.6 12005.0 12020.9 12083.7 12341.8 12334.9 12739.4 12741.9 12744.8 12798.9 10427.4 10469.7 10622.7 10660.2 10706.8 10243.3 10601.9 10606.7 10607.1 10633.8 8619.2 8742.7 8764.7 8853.6 9092.0 8567.7 8676.0 8742.0 8787.8 8812.3 7925.9 8026.6 8050.8 8056.9 8096.4 5286.3 5905.3 5996.8 6068.3 6229.6 5964.6 6090.5 6159.6 6223.5 6419.5 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | [#4] prototype.html Cycles:180 Average:4421.75 Median:4737.82 stddev:1263.79 (26.7%) stddev-sans-first:1229.50 11:42:21 INFO - PROCESS | 2357 | Values: 332.4 384.4 385.4 395.9 399.4 4843.3 5050.3 5072.9 5118.5 5201.5 3865.6 4274.3 4342.0 4973.5 5043.6 3169.6 3355.8 3494.0 3921.0 3960.5 3385.6 3667.8 3925.9 3959.5 3960.4 3360.9 3760.3 3974.4 3984.3 4000.8 3907.5 3983.6 4000.3 4143.2 4200.9 3838.7 3853.9 3887.8 3910.3 3928.6 4172.7 4391.8 4479.4 4872.9 4993.3 3842.4 4163.8 4338.6 4595.9 4644.5 4617.6 5337.9 5356.8 5382.5 5394.6 4297.1 4356.4 4374.4 4402.3 4406.4 4670.6 5341.7 5404.9 5600.2 5823.5 3259.7 4022.1 4394.8 4420.3 4431.8 4518.4 4537.4 4549.0 4573.9 4583.7 4059.9 4361.3 4774.5 4775.9 4879.4 4366.4 4936.2 5309.7 5415.9 5505.4 1403.9 1525.6 1578.6 1579.1 1595.3 1023.3 1085.0 1089.0 1096.1 1166.7 4606.7 4770.6 4963.8 5087.4 5264.4 5061.5 5413.1 5706.9 5746.4 5758.3 4627.4 4652.4 4833.0 5085.5 5172.0 2581.5 2606.4 2624.9 2669.7 2681.0 5033.8 5329.8 5625.5 5780.1 5800.5 5274.0 5347.3 5517.6 5569.9 5693.9 4802.4 5344.9 5717.5 5727.2 5868.0 4811.1 5012.4 5080.7 5244.2 5247.9 4289.8 5361.7 5504.5 5510.0 5534.5 5400.3 5797.4 5827.5 5847.5 5855.9 3833.0 3912.6 3982.4 4339.0 4542.4 4912.8 5346.5 5396.5 5446.5 5464.9 4510.8 5231.6 5255.6 5285.0 5364.7 4739.8 5125.9 5387.0 5387.3 5400.5 4676.9 4735.8 5052.6 5161.0 5203.7 4326.7 5173.2 5180.7 5278.0 5400.0 4480.5 4619.8 5168.0 5285.9 5337.8 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - PROCESS | 2357 | [#5] yui.html Cycles:180 Average:21427.38 Median:17220.64 stddev:29983.62 (174.1%) stddev-sans-first:30027.50 11:42:21 INFO - PROCESS | 2357 | Values: 742.1 761.8 795.9 819.6 884.1 15787.1 16588.4 17581.0 17589.0 17651.9 14471.9 16068.0 16079.0 16213.2 16262.6 970.5 983.0 1009.9 1029.0 1044.6 1020.9 1023.9 1025.0 1026.0 1026.4 1079.8 1080.5 1082.2 1082.2 1083.5 1074.3 1074.5 1074.7 1077.2 1077.4 684.3 798.0 798.1 799.4 800.5 15274.5 16906.1 17535.2 17551.6 17612.6 14687.5 14888.3 14935.8 14970.6 15354.0 12078.6 12150.5 12283.3 12369.2 12393.2 3853.2 3910.1 4007.4 4097.5 4151.4 96294.0 99051.0 105423.5 107683.0 110214.0 11605.7 11743.2 11875.0 12190.9 12370.1 23213.0 23648.9 23755.0 23757.5 23932.5 8218.5 8311.6 8321.5 8410.5 8411.2 4545.2 4617.5 4649.3 4654.8 4667.2 3380.1 3481.0 3484.5 3489.6 3491.0 596.4 605.7 610.2 610.4 627.6 686.1 702.3 709.2 752.1 766.3 10838.3 10889.2 10907.3 11215.7 11399.0 702.4 730.1 733.8 754.9 789.1 4952.0 5216.0 5240.2 5282.2 5291.6 96706.0 97422.5 98791.0 101911.0 102356.5 94346.0 94559.0 96436.5 96649.6 96743.0 85273.0 86331.1 86881.6 87301.6 89596.6 9904.4 10243.4 10250.6 10280.2 10288.9 56041.0 56521.0 56832.0 57149.7 57464.0 58596.4 62913.1 65192.7 72478.3 73614.6 13376.5 13547.7 13675.2 13724.7 14222.3 15258.6 15716.5 15765.5 16717.9 16759.1 11336.4 14183.8 14757.9 14865.4 15173.8 14205.7 14602.3 14629.9 15044.7 15198.5 13411.4 13872.0 13873.9 14106.2 14154.2 10116.5 10235.4 10391.2 10893.3 11037.2 11460.8 11568.7 11692.4 11799.3 11846.8 11:42:21 INFO - PROCESS | 2357 | -------- Summary: end -------- 11:42:21 INFO - PROCESS | 2357 | 11:42:21 INFO - TEST-INFO | 2357: exit 0 11:42:21 INFO - TEST-OK | dromaeo_css | took 1119644ms 11:42:21 INFO - TEST-START | kraken 11:42:21 INFO - operating with platform_type : mac_ 11:42:21 INFO - Initialising browser for kraken test... 11:42:21 INFO - TEST-INFO | started process 2362 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpNNghhU/profile http://localhost:58826/getInfo.html) 11:42:23 INFO - PROCESS | 2362 | __metrics Screen width/height:1600/1200 11:42:23 INFO - PROCESS | 2362 | colorDepth:24 11:42:23 INFO - PROCESS | 2362 | Browser inner width/height: 1024/689 11:42:23 INFO - PROCESS | 2362 | __metrics 11:42:23 INFO - PROCESS | 2362 | 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" 11:42:23 INFO - PROCESS | 2362 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:24 INFO - TEST-INFO | 2362: exit 0 11:42:24 INFO - Browser initialized. 11:42:24 INFO - Running cycle 1/1 for kraken test... 11:42:24 INFO - TEST-INFO | started process 2364 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpNNghhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:36 INFO - PROCESS | 2364 | RSS: Main: 165449728 11:42:36 INFO - PROCESS | 2364 | 11:42:39 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:40 INFO - PROCESS | 2364 | RSS: Main: 216289280 11:42:40 INFO - PROCESS | 2364 | 11:42:42 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-dft) 11:42:43 INFO - PROCESS | 2364 | RSS: Main: 231993344 11:42:43 INFO - PROCESS | 2364 | 11:42:46 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-fft) 11:42:47 INFO - PROCESS | 2364 | RSS: Main: 330223616 11:42:47 INFO - PROCESS | 2364 | 11:42:49 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58826/tests/kraken/driver.html?testName=audio-oscillator) 11:42:49 INFO - PROCESS | 2364 | RSS: Main: 231149568 11:42:49 INFO - PROCESS | 2364 | 11:42:51 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:52 INFO - PROCESS | 2364 | RSS: Main: 232165376 11:42:52 INFO - PROCESS | 2364 | 11:42:55 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58826/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:55 INFO - PROCESS | 2364 | RSS: Main: 272195584 11:42:55 INFO - PROCESS | 2364 | 11:42:58 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58826/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:59 INFO - PROCESS | 2364 | RSS: Main: 273829888 11:42:59 INFO - PROCESS | 2364 | 11:43:02 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58826/tests/kraken/driver.html?testName=json-parse-financial) 11:43:02 INFO - PROCESS | 2364 | RSS: Main: 271933440 11:43:02 INFO - PROCESS | 2364 | 11:43:04 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:43:05 INFO - PROCESS | 2364 | RSS: Main: 248238080 11:43:05 INFO - PROCESS | 2364 | 11:43:07 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:43:07 INFO - PROCESS | 2364 | RSS: Main: 251265024 11:43:07 INFO - PROCESS | 2364 | 11:43:09 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:10 INFO - PROCESS | 2364 | RSS: Main: 254095360 11:43:10 INFO - PROCESS | 2364 | 11:43:13 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:43:14 INFO - PROCESS | 2364 | RSS: Main: 271945728 11:43:14 INFO - PROCESS | 2364 | 11:43:17 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:43:17 INFO - PROCESS | 2364 | RSS: Main: 265691136 11:43:17 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | Cycle 1(1): loaded http://localhost:58826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58826/tests/kraken/driver.html?testName=ai-astar) 11:43:19 INFO - PROCESS | 2364 | RSS: Main: 309858304 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | __start_tp_report 11:43:19 INFO - PROCESS | 2364 | _x_x_mozilla_page_load 11:43:19 INFO - PROCESS | 2364 | _x_x_mozilla_page_load_details 11:43:19 INFO - PROCESS | 2364 | |i|pagename|runs| 11:43:19 INFO - PROCESS | 2364 | |0;ai-astar;103;115;115;114;115;116;115;115;114;114 11:43:19 INFO - PROCESS | 2364 | |1;audio-beat-detection;126;128;134;172;125;108;107;106;128;110 11:43:19 INFO - PROCESS | 2364 | |2;audio-dft;184;185;185;185;184;185;184;183;184;183 11:43:19 INFO - PROCESS | 2364 | |3;audio-fft;85;59;60;95;60;61;60;59;74;62 11:43:19 INFO - PROCESS | 2364 | |4;audio-oscillator;90;69;87;69;68;66;82;68;66;81 11:43:19 INFO - PROCESS | 2364 | |5;imaging-gaussian-blur;90;89;89;88;89;88;90;88;89;88 11:43:19 INFO - PROCESS | 2364 | |6;imaging-darkroom;95;95;95;103;145;94;95;95;109;149 11:43:19 INFO - PROCESS | 2364 | |7;imaging-desaturate;84;84;84;83;86;85;86;83;85;84 11:43:19 INFO - PROCESS | 2364 | |8;json-parse-financial;59;60;59;59;65;62;64;63;63;63 11:43:19 INFO - PROCESS | 2364 | |9;json-stringify-tinderbox;55;58;66;66;59;57;57;58;62;58 11:43:19 INFO - PROCESS | 2364 | |10;stanford-crypto-aes;90;98;72;91;97;97;96;101;83;84 11:43:19 INFO - PROCESS | 2364 | |11;stanford-crypto-ccm;134;133;131;132;131;136;139;131;202;143 11:43:19 INFO - PROCESS | 2364 | |12;stanford-crypto-pbkdf2;158;225;213;161;163;162;160;162;159;160 11:43:19 INFO - PROCESS | 2364 | |13;stanford-crypto-sha256-iterative;72;75;81;82;67;58;81;81;77;80 11:43:19 INFO - PROCESS | 2364 | __end_tp_report 11:43:19 INFO - PROCESS | 2364 | __start_cc_report 11:43:19 INFO - PROCESS | 2364 | _x_x_mozilla_cycle_collect,2070 11:43:19 INFO - PROCESS | 2364 | __end_cc_report 11:43:19 INFO - PROCESS | 2364 | __startTimestamp1493923399815__endTimestamp 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | ------- Summary: start ------- 11:43:19 INFO - PROCESS | 2364 | Number of tests: 14 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.78 (3.3%) stddev-sans-first:0.67 11:43:19 INFO - PROCESS | 2364 | Values: 103.0 115.0 115.0 114.0 115.0 116.0 115.0 115.0 114.0 114.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:127.00 stddev:19.73 (15.5%) stddev-sans-first:20.92 11:43:19 INFO - PROCESS | 2364 | Values: 126.0 128.0 134.0 172.0 125.0 108.0 107.0 106.0 128.0 110.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:0.79 (0.4%) stddev-sans-first:0.83 11:43:19 INFO - PROCESS | 2364 | Values: 184.0 185.0 185.0 185.0 184.0 185.0 184.0 183.0 184.0 183.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#3] audio-fft Cycles:10 Average:67.50 Median:61.50 stddev:12.87 (20.9%) stddev-sans-first:11.99 11:43:19 INFO - PROCESS | 2364 | Values: 85.0 59.0 60.0 95.0 60.0 61.0 60.0 59.0 74.0 62.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:75.00 stddev:9.34 (12.4%) stddev-sans-first:8.07 11:43:19 INFO - PROCESS | 2364 | Values: 90.0 69.0 87.0 69.0 68.0 66.0 82.0 68.0 66.0 81.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:0.79 (0.9%) stddev-sans-first:0.71 11:43:19 INFO - PROCESS | 2364 | Values: 90.0 89.0 89.0 88.0 89.0 88.0 90.0 88.0 89.0 88.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.00 stddev:21.38 (22.5%) stddev-sans-first:22.19 11:43:19 INFO - PROCESS | 2364 | Values: 95.0 95.0 95.0 103.0 145.0 94.0 95.0 95.0 109.0 149.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:1.07 (1.3%) stddev-sans-first:1.13 11:43:19 INFO - PROCESS | 2364 | Values: 84.0 84.0 84.0 83.0 86.0 85.0 86.0 83.0 85.0 84.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:63.00 stddev:2.26 (3.6%) stddev-sans-first:2.18 11:43:19 INFO - PROCESS | 2364 | Values: 59.0 60.0 59.0 59.0 65.0 62.0 64.0 63.0 63.0 63.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:58.50 stddev:3.81 (6.5%) stddev-sans-first:3.66 11:43:19 INFO - PROCESS | 2364 | Values: 55.0 58.0 66.0 66.0 59.0 57.0 57.0 58.0 62.0 58.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:93.50 stddev:8.95 (9.6%) stddev-sans-first:9.49 11:43:19 INFO - PROCESS | 2364 | Values: 90.0 98.0 72.0 91.0 97.0 97.0 96.0 101.0 83.0 84.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:135.00 stddev:21.72 (16.1%) stddev-sans-first:22.89 11:43:19 INFO - PROCESS | 2364 | Values: 134.0 133.0 131.0 132.0 131.0 136.0 139.0 131.0 202.0 143.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:162.00 stddev:24.82 (15.3%) stddev-sans-first:25.78 11:43:19 INFO - PROCESS | 2364 | Values: 158.0 225.0 213.0 161.0 163.0 162.0 160.0 162.0 159.0 160.0 11:43:19 INFO - PROCESS | 2364 | 11:43:19 INFO - PROCESS | 2364 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:80.50 stddev:7.79 (9.7%) stddev-sans-first:8.17 11:43:19 INFO - PROCESS | 2364 | Values: 72.0 75.0 81.0 82.0 67.0 58.0 81.0 81.0 77.0 80.0 11:43:19 INFO - PROCESS | 2364 | -------- Summary: end -------- 11:43:19 INFO - PROCESS | 2364 | 11:43:20 INFO - TEST-INFO | 2364: exit 0 11:43:20 INFO - TEST-OK | kraken | took 58959ms 11:43:20 INFO - SUITE-END | took 1178s 11:43:20 INFO - Completed test suite (00:19:38) 11:43:20 INFO - javascript benchmark 11:43:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7846.9641554776545, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2951.5425109108082, 3352.296017836254, 3508.4561892906577, 3511.2275299434114, 3527.982360088199, 6022.066579680151, 6089.421504957022, 6107.38926107389, 6134.969325153379, 6165.260168779747, 6100.603460775046, 6127.693615319238, 6170.660613666258, 6178.227721534809, 6203.162573052637, 5396.91904621431, 5424.294841670578, 5459.208414779854, 5465.890682186354, 5537.778488860461, 5330.440303768107, 5335.146376579748, 5337.759800808973, 5501.862453438656, 5560.805371811967, 5406.405295417501, 5427.945720542783, 5432.809851655193, 5439.782408703667, 5440.129579267318, 5418.620696551243, 5423.186522021689, 5424.593155513333, 5426.647267927572, 5428.4028756836915, 5255.894882102375, 5385.4883786040655, 5387.703676297802, 5398.0, 5425.02349577076, 6096.466212027279, 6096.889554637394, 6098.704546243851, 6107.461915314337, 6130.367562715059, 6330.430261276461, 6361.936380636181, 6373.490120790326, 6376.968115159394, 6389.8402539936405, 5603.523700485463, 6484.286728459866, 6577.769778057793, 6582.275949645536, 6586.407223349922, 5210.817621383271, 5273.3935597406025, 5543.722813859291, 6244.6253224806205, 6272.090546870678, 6523.967380163069, 6525.738970441224, 6573.605583664996, 6595.8351041223395, 6603.504737144734, 6377.553571249968, 6383.425491705769, 6386.680665966683, 6389.616623002635, 6414.973604223302, 6566.3105373936005, 6582.506312026617, 6587.110740050032, 6589.275179730226, 6591.6374599397495, 6206.937930620636, 6265.0, 6359.459445947146, 6375.458086062644, 6490.188726409199, 6472.35276472349, 6491.902621460682, 6493.350664933469, 6503.0, 6533.41199292066, 5233.1365324721755, 5249.2126181073145, 5271.525562699376, 5275.60432967529, 5304.681719096867, 4600.309953506934, 4605.470370907322, 4605.861824145281, 4619.838305659353, 4698.530146985342, 6146.0, 6194.721237544231, 6221.377862213742, 6223.719932603044, 6229.034499652561, 6602.86794264112, 6607.76872809459, 6616.007598860209, 6624.436922861611, 6646.6676666166495, 6210.937890621036, 6221.253449586078, 6244.406781355764, 6255.530835187288, 6261.154744109578, 5622.887542249132, 5674.177244299553, 5696.715164241771, 5701.429857014348, 5744.741486633112, 6612.173478315211, 6624.8343791405605, 6635.270120286861, 6636.170478690164, 6664.700088496126, 6416.903746443901, 6443.09796628463, 6452.451541619015, 6457.192850893638, 6500.28496865335, 5462.426445223353, 6839.658017099225, 6843.110395648534, 6861.0, 6868.62222577763, 6482.57863238888, 6485.740570377321, 6488.383603557654, 6491.350864913471, 6492.156019717407, 6331.0819931110655, 6373.776917807854, 6472.0291956205065, 6586.077949087035, 6609.074729537965, 6262.5929314594405, 6360.300366959723, 6402.007688808242, 6427.325130861379, 6432.903506447314, 6410.711517981796, 6415.1981002374705, 6423.550351475352, 6436.6459844707115, 6439.291677915519, 6196.535259855619, 6222.066689996536, 6283.994560870239, 6301.149344838388, 6314.179156709598, 6329.620222786648, 6407.391297826699, 6425.678716064272, 6441.935580644321, 6446.355364463516, 6294.968525157345, 6295.685215739286, 6305.211848518935, 6305.4009869062365, 6318.936810631835], "value": 5974.184293206432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.8067983004249, 812.0012384766736, 911.1435250864187, 912.352229916759, 989.154273096503, 30311.696883031163, 40468.59531404685, 43196.56803431965, 43206.135877282475, 43268.56731432685, 40977.795111024476, 41356.379654305136, 41375.0, 41377.58622413775, 41409.96475088124, 7794.8441031179345, 8089.312408445289, 8241.175882411771, 8242.958785206065, 8260.339172866155, 7880.330171935392, 11641.18511704181, 11875.821862672066, 12173.087018473605, 12181.57364492243, 11892.583759568417, 11929.0, 11932.403379831017, 11944.283342999404, 11953.22304050234, 11858.584949526768, 11883.40582970848, 11888.46501907412, 11893.226940248942, 11907.0, 11447.0, 11517.308961462339, 11530.884691153065, 11536.884631153665, 11537.769244615061, 40289.59710402917, 40580.0, 40631.59368406337, 40647.7967610163, 40698.77903662895, 3941.7437866538585, 4022.255882661688, 4031.23406552754, 4031.7984100794843, 4041.2927737645796, 28655.426891462263, 28887.277818054506, 30133.698663013307, 31076.844615776776, 31731.84134079338, 3158.921026974344, 3224.1456014156265, 3298.307355455357, 3373.241020770307, 3405.2848901730667, 321354.0, 329337.0, 330979.0, 333181.0, 333490.0, 43238.0, 43896.56103438925, 52099.437016889555, 52176.739116304176, 52187.21719174215, 47270.29094563585, 58026.0, 58063.70968145132, 59038.70480647569, 59039.704801476575, 16002.839971600135, 16072.437464688679, 16080.919595401949, 16095.0, 16095.919520402556, 13559.932200338935, 13574.457021719021, 13580.592582222549, 13608.183508989492, 13620.591382258548, 13111.541096061783, 13158.342082895817, 13272.070955033249, 13286.601401957956, 13359.332033398292, 5805.651660900359, 5820.970895145582, 5829.8251052468495, 5839.0, 5845.883082338414, 1156.0462618339902, 1161.4250945781891, 1164.5400066973498, 1169.9473523691454, 1223.174357308813, 19706.70439943402, 26989.190324290303, 27442.862785685942, 27471.0, 27529.86235068852, 938.8075444533854, 1172.9296242225494, 1177.1877404590975, 1217.8051511758254, 1341.9597412077458, 13755.862441375659, 14024.929875350557, 14070.507532236323, 14220.431182752782, 14311.499097531536, 376468.0, 490282.5485872548, 495388.0, 586347.0, 587823.0, 49979.000419992124, 50149.0, 50276.994460110596, 50283.49716502861, 50491.49508504941, 1456.3664805809506, 1486.799282096903, 1495.9775603365958, 1502.9549113526393, 1507.547735679292, 26457.33856653599, 27643.447131056862, 28087.0169544065, 28236.71763282341, 28242.0, 33808.985730428125, 41165.58834411618, 41204.38193427161, 41241.793791030854, 41285.58714412938, 468926.0, 469859.30140698154, 470089.0, 470196.0, 470873.0, 24655.38361540976, 24975.87608557583, 29298.853505732335, 31240.531392029592, 31983.36033279368, 41312.0, 41520.546780862525, 41975.7901210492, 42051.15897681968, 42596.78701606472, 23141.88429057844, 28590.857045714638, 28688.569671455363, 29349.853250734464, 30302.0, 29003.854980724962, 29504.557431638113, 29911.252218694706, 30051.69948300489, 30142.54786178165, 34530.82734586311, 35585.288294233455, 35643.82178089093, 35663.46504802482, 35682.82158589294, 26335.0, 28497.860085597174, 28531.14406567806, 29101.12696619105, 29708.0, 22676.465629245715, 23553.76446235584, 23854.0, 24187.0, 24272.0], "value": 19069.441413230732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.9830478897115, 385.5277285325476, 424.4630542363908, 427.36322878910414, 465.527489598058, 18566.72149917752, 20585.970701464925, 21236.681449778265, 22365.888170559123, 22477.32568022958, 19189.808101918978, 23515.529689406245, 23735.0, 24265.0, 24547.75452245477, 6604.513984353518, 6880.105586273802, 6921.273266307041, 6924.0, 6928.168619765635, 6439.452646525051, 6768.052472653832, 6836.521443498932, 6847.520673552828, 6854.862902741942, 6524.771632992846, 6796.660166991655, 6816.897746533781, 6833.487488438363, 6844.110265665457, 6792.490563207779, 6843.863122737517, 6846.212685541177, 6848.554843935129, 6897.137857767779, 5616.887662246773, 6222.96888515559, 6578.342165783383, 6578.440832529241, 6581.506387020992, 28457.857710711312, 28459.71540284612, 28470.861165553353, 28472.7187276571, 28503.429931401257, 3017.517197248452, 3025.909222723322, 3035.893743718981, 3068.2789544457037, 3078.9993252192903, 16674.49976500707, 16877.240524176443, 17016.744748828653, 17106.401275955282, 17281.654366912593, 2062.6802845558964, 2088.5300807318386, 2092.5814837032503, 2112.3134981131193, 2129.1057755742627, 122800.0, 145582.0, 146619.0, 148628.0, 148876.99999999892, 21468.248611298528, 21541.0, 21545.56908861814, 21684.24105156312, 21781.346559603237, 34468.65531344654, 35094.9471515855, 35156.824215878754, 35324.47013294802, 35334.46998295028, 10929.508172132273, 11257.043151332065, 11419.885801142049, 11429.885701143048, 11624.302541847515, 9280.535973201313, 9300.302477314228, 9309.16217540411, 9528.571214295373, 9537.2370210383, 8200.917990820015, 10190.694279171637, 10235.948820255851, 10246.743831404125, 10347.120494757879, 3193.7924034937655, 4045.8988525287104, 4179.540250572434, 4258.339957306623, 4262.296721041055, 988.5996171550534, 994.7562847102506, 998.3610489286717, 1034.6637342863598, 1088.145805542661, 22108.88945555262, 23112.537749244922, 23249.535009299718, 23277.53444931092, 23323.88338058299, 1066.2589500297374, 1070.47011729193, 1090.1878100814943, 1101.944902754859, 1111.4220605285207, 12013.0, 12218.26690398579, 12225.938870305592, 12322.75354492923, 12411.565595204125, 685822.0, 731931.0, 732485.0, 779763.1011844905, 786010.0, 131500.0, 134845.3257733705, 137149.0, 138895.0, 141889.29055354864, 1267.467663581298, 1284.6146156153118, 1312.534050412109, 1314.3165553911913, 1316.5457917018614, 19503.0, 19616.509587260432, 19912.800871991672, 19941.105594968456, 19972.70040949358, 57062.42937570571, 57473.0, 58111.70944145252, 59015.0, 59031.70484147552, 80237.19762802297, 80795.19204807877, 81123.78314325408, 82967.0, 83787.0, 12078.282022651043, 12184.634460966185, 12330.938345308216, 12563.560275390317, 12651.557195498113, 13587.660308492366, 13673.24797136167, 13707.451701931812, 14105.576832695035, 14134.646633834236, 11678.88321116778, 11970.76058478843, 12045.217060891015, 12197.75604487923, 12244.632661020183, 9877.753056173653, 10598.417087059977, 11181.161412894227, 11183.496742646763, 11648.708782280512, 11586.478608462809, 12061.51753929833, 12112.636620901387, 12196.963258123158, 12246.265224086583, 12100.697482563006, 12122.757544848877, 12293.44679489443, 12304.0, 12460.501579937063, 10665.733356665834, 11743.823842642538, 11942.402879856147, 12048.0, 12079.75840483203], "value": 11928.168047622206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.7584798508246, 1569.7802307676934, 1605.165314036701, 1630.1849075462264, 1636.190085907476, 10884.891151088486, 11564.479598418071, 11571.421428928552, 11571.942140289297, 11575.305481671106, 11085.334879907192, 11279.661610151688, 11388.0, 11627.941860290708, 11635.767284654301, 2450.4363996280867, 2491.788198003172, 2497.987510062447, 2499.7750202481775, 2508.2726009457238, 2150.84929562684, 2291.2897001929373, 2414.4808866093786, 2456.6192240202795, 2468.7778099971, 2385.6779334789753, 2455.0670745116918, 2465.938351541217, 2466.519028789387, 2475.1337032038823, 2173.652215645505, 2209.91714060111, 2447.2780529743677, 2456.4350199454225, 2458.7172475165316, 2447.0823441209545, 2468.7160976487753, 2471.159805666064, 2472.666190064336, 2476.4799392127675, 11237.157213209042, 11447.370394628291, 11462.541498340057, 11467.31196128235, 11469.713257168554, 5934.347221805598, 6083.665398403086, 6102.1151932969915, 6103.359147289515, 6141.508679305645, 3600.7299452541165, 3681.7975011374365, 3692.649198326155, 3752.2683076800035, 3755.380362240227, 1206.7707135644287, 1229.0659099084671, 1254.3540076860425, 1268.9111762176651, 1288.5618889577495, 14042.1574705518, 14322.785158222636, 14664.853351466456, 15795.921020394824, 15948.441804536902, 4095.4675892133832, 4336.3278691802825, 4393.29707246839, 4455.086707225076, 4885.682430642068, 11999.820002699966, 12001.759964800654, 12033.217840840318, 12035.097367697283, 12048.457819398149, 5978.611390259619, 5990.371011043865, 6003.5797494174985, 6017.879642407127, 6028.0355143176885, 5174.482551744795, 5391.191321301836, 5439.401665816757, 5489.862753431116, 5495.148252020943, 3922.9215415692097, 3957.406389041609, 4015.1768887378603, 4020.2562525932794, 4064.8170832312617, 867.3798234262532, 1026.573971801694, 1045.7019749371545, 1046.3774054437597, 1047.7904419116207, 963.2246041936309, 1002.8997100289913, 1006.3911333643186, 1009.7374682582581, 1039.3036665434176, 6626.237982632059, 6744.325567443217, 6747.763828265987, 6903.482238832108, 6945.0, 895.7044175422095, 994.8656931314325, 1022.3099407899638, 1050.558765318568, 1066.7919755647729, 4120.62914337711, 4163.916721665611, 4166.229247589205, 4177.728447650893, 4224.260754367973, 13382.799258011137, 14089.15465072099, 14104.012719109769, 14115.294235288195, 14119.85880141206, 13900.16599004063, 14002.57992260234, 14024.368903399372, 14033.508827191203, 14064.945129115356, 8483.406161568631, 8850.690225842065, 9145.81708365829, 10284.485775711184, 10290.228232882564, 6056.3035250946705, 6599.934000659932, 6643.900341494785, 6675.23234828001, 7002.544834585736, 11948.581799636971, 12005.0, 12020.939895300467, 12083.697907552381, 12341.75316493683, 12334.938325308316, 12739.426725797546, 12741.936290318488, 12744.808827867404, 12798.872011279767, 10427.426491542734, 10469.68590942273, 10622.681319560426, 10660.200484963503, 10706.785864282827, 10243.282970192313, 10601.893981060091, 10606.681799546026, 10607.098396636373, 10633.787324253626, 8619.1811777881, 8742.694005709769, 8764.693235736719, 8853.601587928688, 9092.045335239969, 8567.700130495403, 8675.956620217112, 8742.038375778786, 8787.780305492413, 8812.339074569305, 7925.881111783443, 8026.59867006659, 8050.83898322042, 8056.879146812919, 8096.39277054235, 5286.286351342519, 5905.261842269716, 5996.760129594767, 6068.302145253352, 6229.626222426669, 5964.582479226413, 6090.482309003784, 6159.599626024294, 6223.502119830493, 6419.45434638061], "value": 5235.578522659545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3535723018729, 384.39649749892646, 385.44495925866767, 395.86540576204084, 399.4288167919875, 4843.297721830332, 5050.29295898574, 5072.9492705072935, 5118.462561431043, 5201.531862132408, 3865.6083809828438, 4274.337477690963, 4341.956580434195, 4973.52751488608, 5043.646944713872, 3169.603799525065, 3355.832208389583, 3493.982530087346, 3920.9607903920883, 3960.4950118954903, 3385.628820327759, 3667.7529639922554, 3925.862594809182, 3959.485266915297, 3960.4059391091278, 3360.9159771005798, 3760.2667479841443, 3974.4237085622567, 3984.262911361393, 4000.8399664013405, 3907.5310962684375, 3983.6414722674954, 4000.339943909266, 4143.233501802176, 4200.894977625584, 3838.7120965927666, 3853.8651147209994, 3887.803391084057, 3910.296146693594, 3928.6464218220212, 4172.728772629769, 4391.802368893407, 4479.372887795711, 4872.853814385574, 4993.252361673422, 3842.385218365076, 4163.834126444601, 4338.631216346583, 4595.885102872455, 4644.489106198315, 4617.568553748349, 5337.919931201035, 5356.785728570852, 5382.4886635769535, 5394.622376433651, 4297.119090586453, 4356.411884395598, 4374.431323927869, 4402.295632698753, 4406.405135306757, 4670.579647831712, 5341.679499230058, 5404.891902161974, 5600.243967064475, 5823.5341172706085, 3259.707695227837, 4022.1352409232154, 4394.8242070317465, 4420.270655341897, 4431.8448854289945, 4518.367428560005, 4537.3647689323525, 4548.977255113703, 4573.862784116415, 4583.656225783079, 4059.918801623951, 4361.302191649384, 4774.522547745267, 4775.904481910412, 4879.39007624047, 4366.43236379275, 4936.185529387682, 5309.699123714715, 5415.891682166334, 5505.449455054542, 1403.943842246319, 1525.6262215756988, 1578.5580037589493, 1579.136618789816, 1595.3060418717894, 1023.2808881079858, 1084.9620263290906, 1088.9564417423373, 1096.1066730614523, 1166.731651720109, 4606.677532572688, 4770.570648641569, 4963.808685915426, 5087.448328259842, 5264.42091369949, 5061.519155680205, 5413.105413105461, 5706.857328566819, 5746.42535746422, 5758.280214973129, 4627.444706635158, 4652.418447694038, 4832.975835120872, 5085.542301192911, 5171.974140129275, 2581.457893842314, 2606.387498937748, 2624.9212523624324, 2669.745219746716, 2681.037453613768, 5033.79864805411, 5329.813456529003, 5625.493705566437, 5780.132980052942, 5800.50695690871, 5274.0, 5347.3048503695045, 5517.61376703635, 5569.944300556943, 5693.943060569424, 4802.391198948251, 5344.946550534522, 5717.542596592346, 5727.151550854024, 5867.973104706659, 4811.133995880775, 5012.39355535127, 5080.669756465966, 5244.239585260192, 5247.921281180862, 4289.7640629765665, 5361.651492652965, 5504.504594586507, 5510.0, 5534.4742249486235, 5400.324959380077, 5797.434577734747, 5827.484853937922, 5847.473727364558, 5855.94144058554, 3832.9616703832603, 3912.6087391260644, 3982.3628219484744, 4338.978305108454, 4542.364069030405, 4912.778924948458, 5346.545543628835, 5396.542933408036, 5446.537044351275, 5464.890702186013, 4510.797014134438, 5231.607629427732, 5255.579553635776, 5285.0, 5364.731763411735, 4739.819682945884, 5125.948740512547, 5386.976474469838, 5387.299651045339, 5400.513953744182, 4676.929846052244, 4735.810567577259, 5052.635788337055, 5161.0, 5203.725204900866, 4326.740395576276, 5173.188934290995, 5180.7150606717, 5277.973610131925, 5400.0, 4480.507144214199, 4619.769011549476, 5168.0, 5285.920711189258, 5337.759800808895], "value": 4060.8606475092142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.1168809117147, 761.8438220164863, 795.9363250939925, 819.6188772220916, 884.1423818895669, 15787.052776833383, 16588.419405320816, 17581.03304318262, 17589.0, 17651.911740441297, 14471.92764036181, 16068.0, 16079.035257884536, 16213.189340532985, 16262.593435164097, 970.5001924009141, 982.9852552211722, 1009.8639031090024, 1028.984565231522, 1044.5560636729397, 1020.8979102089805, 1023.918086553074, 1024.9795004099951, 1026.0304012707993, 1026.4405898785142, 1079.8164312066967, 1080.5461706083463, 1082.1667316166547, 1082.2262082610932, 1083.544911137324, 1074.3231763988715, 1074.457399013501, 1074.6668532754793, 1077.154433769491, 1077.4343469678404, 684.3156843156843, 797.9905419644155, 798.0941631248575, 799.4403917257943, 800.4676889868231, 15274.541763747106, 16906.070166140857, 17535.210915508833, 17551.648967020716, 17612.647747044986, 14687.485937992118, 14888.330025148894, 14935.775963360558, 14970.62573435662, 15354.0, 12078.637640870787, 12150.45322960469, 12283.263004219776, 12369.196002259825, 12393.194442361219, 3853.2100919311474, 3910.1295273813084, 4007.3788562772816, 4097.487814023247, 4151.4395556599775, 96294.0, 99051.00948990561, 105423.47288263586, 107683.0, 110214.0, 11605.709857253636, 11743.236689615147, 11875.0, 12190.878091219152, 12370.13409061357, 23213.0, 23648.881755591457, 23755.049798008233, 23757.524849502912, 23932.52134957291, 8218.465799722999, 8311.584420778936, 8321.459105158145, 8410.453320534145, 8411.242988130974, 4545.227311357011, 4617.46899106607, 4649.349091127245, 4654.767261636905, 4667.183242932473, 3380.053584996205, 3480.9731129316406, 3484.4599087141532, 3489.5638045244345, 3490.9650903491147, 596.4423264247943, 605.748614325059, 610.1549354144541, 610.4079043327964, 627.626562195493, 686.0978062794408, 702.3362922038624, 709.1950636028146, 752.1049950558818, 766.3103207113643, 10838.349699018085, 10889.183311251687, 10907.29102608328, 11215.66353009411, 11399.0, 702.3924305475726, 730.1384366447537, 733.8458923625991, 754.8754455514778, 789.0886026639241, 4951.975240123848, 5216.0, 5240.213611279005, 5282.2340760589495, 5291.603129765283, 96706.0, 97422.5128874351, 98791.0, 101911.0, 102356.48821755992, 94346.0, 94559.0, 96436.51781741047, 96649.55025674621, 96743.0, 85273.0, 86331.13668863356, 86881.56559217164, 87301.56349218213, 89596.55201723949, 9904.356216845881, 10243.436610986468, 10250.58997640086, 10280.22898282617, 10288.948555257175, 56041.0, 56521.0, 56832.0, 57149.71425142848, 57464.0, 58596.4140358608, 62913.05630415456, 65192.67403662951, 72478.27521724926, 73614.63192684003, 13376.464941402235, 13547.661308467366, 13675.24786136772, 13724.660269593176, 14222.288885555889, 15258.618534536725, 15716.528504144893, 15765.527034188992, 16717.91641041787, 16759.07825069633, 11336.376499292619, 14183.79437747803, 14757.92621036888, 14865.405383784528, 15173.772393413887, 14205.715885682435, 14602.342894569558, 14629.92685036568, 15044.699106018037, 15198.46805361807, 13411.396487158296, 13872.028957972845, 13873.861261387257, 14106.224157671426, 14154.221517816619, 10116.494175291353, 10235.437050962268, 10391.168706503311, 10893.291936024134, 11037.172212084286, 11460.829791580458, 11568.743503150668, 11692.415379231175, 11799.292042477478, 11846.763064738829], "value": 8079.667145383032, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1446.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 114.0, 115.0, 116.0, 115.0, 115.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 134.0, 172.0, 125.0, 108.0, 107.0, 106.0, 128.0, 110.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 185.0, 185.0, 184.0, 185.0, 184.0, 183.0, 184.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 60.0, 95.0, 60.0, 61.0, 60.0, 59.0, 74.0, 62.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 87.0, 69.0, 68.0, 66.0, 82.0, 68.0, 66.0, 81.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 88.0, 89.0, 88.0, 90.0, 88.0, 89.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 103.0, 145.0, 94.0, 95.0, 95.0, 109.0, 149.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 83.0, 86.0, 85.0, 86.0, 83.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 65.0, 62.0, 64.0, 63.0, 63.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 66.0, 66.0, 59.0, 57.0, 57.0, 58.0, 62.0, 58.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 98.0, 72.0, 91.0, 97.0, 97.0, 96.0, 101.0, 83.0, 84.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 131.0, 132.0, 131.0, 136.0, 139.0, 131.0, 202.0, 143.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 225.0, 213.0, 161.0, 163.0, 162.0, 160.0, 162.0, 159.0, 160.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 81.0, 82.0, 67.0, 58.0, 81.0, 81.0, 77.0, 80.0], "value": 75.4, "unit": "score"}]}]} 11:43:21 INFO - Return code: 0 11:43:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:43:21 INFO - # TBPL SUCCESS # 11:43:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:43:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:43:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:43:21 INFO - 2017-05-04 11:43:21.113 screenresolution[2368:33651] starting screenresolution argv=screenresolution get 11:43:21 INFO - 2017-05-04 11:43:21.116 screenresolution[2368:33651] Display 0: 1600x1200x32@60 11:43:21 INFO - 2017-05-04 11:43:21.122 screenresolution[2369:33654] starting screenresolution argv=screenresolution list 11:43:21 INFO - Available Modes on Display 0 11:43:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:43:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:43:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:43:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:43:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:43:21 INFO - Intel Iris: 11:43:21 INFO - Chipset Model: Intel Iris 11:43:21 INFO - Type: GPU 11:43:21 INFO - Bus: Built-In 11:43:21 INFO - VRAM (Dynamic, Max): 1536 MB 11:43:21 INFO - Vendor: Intel (0x8086) 11:43:21 INFO - Device ID: 0x0a2e 11:43:21 INFO - Revision ID: 0x0009 11:43:21 INFO - Displays: 11:43:21 INFO - Display: 11:43:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:43:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:43:21 INFO - Display Serial Number: 1600x1200 60 11:43:21 INFO - Main Display: Yes 11:43:21 INFO - Mirror: Off 11:43:21 INFO - Online: Yes 11:43:21 INFO - Rotation: Supported 11:43:21 INFO - Return code: 0 11:43:21 INFO - Running post-action listener: _resource_record_post_action 11:43:21 INFO - [mozharness: 2017-05-04 18:43:21.360967Z] Finished run-tests step (success) 11:43:21 INFO - Running post-run listener: _resource_record_post_run 11:43:21 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 1490944; Write bytes: 423555072; Read time: 9; Write time: 1503 11:43:21 INFO - TinderboxPrint: CPU usage
53.7% 11:43:21 INFO - TinderboxPrint: I/O read bytes / time
1,490,944 / 9 11:43:21 INFO - TinderboxPrint: I/O write bytes / time
423,555,072 / 1,503 11:43:21 INFO - TinderboxPrint: CPU idle
2,211.2 (46.3%) 11:43:21 INFO - TinderboxPrint: CPU system
951.9 (19.9%) 11:43:21 INFO - TinderboxPrint: CPU user
1,614.4 (33.8%) 11:43:21 INFO - TinderboxPrint: Swap in / out
123,027,456 / 0 11:43:21 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119300608; Write bytes: 115636224; Read time: 10804; Write time: 320 11:43:21 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 577536; Write bytes: 296794112; Read time: 4; Write time: 1145 11:43:21 INFO - Running post-run listener: _upload_blobber_files 11:43:21 INFO - Blob upload gear active. 11:43:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43:21 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 11:43:21 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:43:21 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:43:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:23 INFO - (blobuploader) - INFO - Done attempting. 11:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:24 INFO - (blobuploader) - INFO - Done attempting. 11:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:26 INFO - (blobuploader) - INFO - Done attempting. 11:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:28 INFO - (blobuploader) - INFO - Done attempting. 11:43:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:28 INFO - Return code: 0 11:43:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7038320665a7c5fdda1bf023a0fcb98d6b3c15cbc3f43e995d211550393c34816249b5676c10e7274448a187f4e559ae0a2a951f79ea63cdbf9c670f0f51d276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c91f2b0b25c1cdeb64c277ad2ef61783c73e12dc8be73306e5890459b73762bf591502fc41cd7ef26063d4a1779324de29ff030256f0ba1fc22c75776881a826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0ee31a48a3fcbd979dca859865bdd983b0219d92228248c8a9985ea331996142672b73b1bf03e145309cab852188725572c0901932964d7ffaa4d4f8044d207", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aecea5efc4e9c215bbcfe207a696edfd8b1ec90f292ebd129e96de4bc6a37fbcf89efcb218c4ad2822330d903cf75783e8507a2185a209e7291d73bb5af2b7d0"} 11:43:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:28 INFO - Contents: 11:43:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7038320665a7c5fdda1bf023a0fcb98d6b3c15cbc3f43e995d211550393c34816249b5676c10e7274448a187f4e559ae0a2a951f79ea63cdbf9c670f0f51d276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c91f2b0b25c1cdeb64c277ad2ef61783c73e12dc8be73306e5890459b73762bf591502fc41cd7ef26063d4a1779324de29ff030256f0ba1fc22c75776881a826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0ee31a48a3fcbd979dca859865bdd983b0219d92228248c8a9985ea331996142672b73b1bf03e145309cab852188725572c0901932964d7ffaa4d4f8044d207", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aecea5efc4e9c215bbcfe207a696edfd8b1ec90f292ebd129e96de4bc6a37fbcf89efcb218c4ad2822330d903cf75783e8507a2185a209e7291d73bb5af2b7d0"} 11:43:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:28 INFO - Copying logs to upload dir... 11:43:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.799828 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-04 11:43:28.601240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 11:43:28.605155) ========= 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.TQdPHDeTKO/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.ipVsnSotlY/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-Beta/sha512/7038320665a7c5fdda1bf023a0fcb98d6b3c15cbc3f43e995d211550393c34816249b5676c10e7274448a187f4e559ae0a2a951f79ea63cdbf9c670f0f51d276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c91f2b0b25c1cdeb64c277ad2ef61783c73e12dc8be73306e5890459b73762bf591502fc41cd7ef26063d4a1779324de29ff030256f0ba1fc22c75776881a826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0ee31a48a3fcbd979dca859865bdd983b0219d92228248c8a9985ea331996142672b73b1bf03e145309cab852188725572c0901932964d7ffaa4d4f8044d207", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aecea5efc4e9c215bbcfe207a696edfd8b1ec90f292ebd129e96de4bc6a37fbcf89efcb218c4ad2822330d903cf75783e8507a2185a209e7291d73bb5af2b7d0"} build_url:https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7038320665a7c5fdda1bf023a0fcb98d6b3c15cbc3f43e995d211550393c34816249b5676c10e7274448a187f4e559ae0a2a951f79ea63cdbf9c670f0f51d276", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c91f2b0b25c1cdeb64c277ad2ef61783c73e12dc8be73306e5890459b73762bf591502fc41cd7ef26063d4a1779324de29ff030256f0ba1fc22c75776881a826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0ee31a48a3fcbd979dca859865bdd983b0219d92228248c8a9985ea331996142672b73b1bf03e145309cab852188725572c0901932964d7ffaa4d4f8044d207", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aecea5efc4e9c215bbcfe207a696edfd8b1ec90f292ebd129e96de4bc6a37fbcf89efcb218c4ad2822330d903cf75783e8507a2185a209e7291d73bb5af2b7d0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 11:43:28.640718) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:43:28.641068) ========= 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.TQdPHDeTKO/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.ipVsnSotlY/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005333 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:43:28.689802) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 11:43:28.690144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 11:43:28.690510) ========= ========= Total master_lag: 0.55 =========