builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0057 starttime: 1493006913.07 results: success (0) buildid: 20170423203420 builduid: cc0f1a6afd1440dda35aaeef4181e51e revision: 933ced9c93e90cd1987c6b5f08dbada24eb2b781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.072574) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.073078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.073366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.099588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.099965) ========= 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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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-04-23 21:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 61.1M=0s 2017-04-23 21:08:33 (61.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147726 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.273086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.273413) ========= 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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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.028808 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:33.324655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-23 21:08:33.325032) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 933ced9c93e90cd1987c6b5f08dbada24eb2b781 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 933ced9c93e90cd1987c6b5f08dbada24eb2b781 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L4kfAUB1bY/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.HUm0vHbYBk/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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-04-23 21:08:33,439 truncating revision to first 12 chars 2017-04-23 21:08:33,439 Setting DEBUG logging. 2017-04-23 21:08:33,439 attempt 1/10 2017-04-23 21:08:33,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/933ced9c93e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-23 21:08:34,901 unpacking tar archive at: mozilla-central-933ced9c93e9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.748990 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-23 21:08:35.098640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:35.099102) ========= script_repo_revision: 933ced9c93e90cd1987c6b5f08dbada24eb2b781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:35.099658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:35.104134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 21:08:35.129385) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-23 21:08:35.129773) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L4kfAUB1bY/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.HUm0vHbYBk/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:08:35 INFO - MultiFileLogger online at 20170423 21:08:35 in /builds/slave/test 21:08:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:08:35 INFO - {'append_to_log': False, 21:08:35 INFO - 'base_work_dir': '/builds/slave/test', 21:08:35 INFO - 'blob_upload_branch': 'Firefox', 21:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:08:35 INFO - 'branch': 'Firefox', 21:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 21:08:35 INFO - 'config_files': ('talos/mac_config.py',), 21:08:35 INFO - 'default_actions': ('clobber', 21:08:35 INFO - 'read-buildbot-config', 21:08:35 INFO - 'download-and-extract', 21:08:35 INFO - 'populate-webroot', 21:08:35 INFO - 'create-virtualenv', 21:08:35 INFO - 'install', 21:08:35 INFO - 'run-tests'), 21:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:08:35 INFO - 'download_minidump_stackwalk': True, 21:08:35 INFO - 'download_symbols': 'ondemand', 21:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 21:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 21:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:08:35 INFO - 'gecko_profile': False, 21:08:35 INFO - 'gecko_profile_interval': 0, 21:08:35 INFO - 'installer_path': 'installer.exe', 21:08:35 INFO - 'log_level': 'info', 21:08:35 INFO - 'log_name': 'talos', 21:08:35 INFO - 'log_to_console': True, 21:08:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:08:35 INFO - 'opt_config_files': (), 21:08:35 INFO - 'pip_index': False, 21:08:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:08:35 INFO - 'cmd': ('bash', 21:08:35 INFO - '-c', 21:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:08:35 INFO - 'enabled': True, 21:08:35 INFO - 'halt_on_failure': False, 21:08:35 INFO - 'name': 'check_screen_resolution'},), 21:08:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:08:35 INFO - 'cmd': ('bash', 21:08:35 INFO - '-c', 21:08:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:08:35 INFO - 'enabled': True, 21:08:35 INFO - 'halt_on_failure': False, 21:08:35 INFO - 'name': 'check_screen_resolution'},), 21:08:35 INFO - 'run_cmd_checks_enabled': True, 21:08:35 INFO - 'suite': 'dromaeojs', 21:08:35 INFO - 'system_bits': '32', 21:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:08:35 INFO - 'title': 't-yosemite-r7-0057', 21:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:08:35 INFO - 'use_talos_json': True, 21:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:08:35 INFO - 'work_dir': 'build'} 21:08:35 INFO - [mozharness: 2017-04-24 04:08:35.349581Z] Running clobber step. 21:08:35 INFO - Running pre-action listener: _resource_record_pre_action 21:08:35 INFO - Running main action method: clobber 21:08:35 INFO - rmtree: /builds/slave/test/build 21:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:08:38 INFO - Running post-action listener: _resource_record_post_action 21:08:38 INFO - [mozharness: 2017-04-24 04:08:38.022305Z] Finished clobber step (success) 21:08:38 INFO - [mozharness: 2017-04-24 04:08:38.022576Z] Running read-buildbot-config step. 21:08:38 INFO - Running pre-action listener: _resource_record_pre_action 21:08:38 INFO - Running main action method: read_buildbot_config 21:08:38 INFO - Using buildbot properties: 21:08:38 INFO - { 21:08:38 INFO - "project": "", 21:08:38 INFO - "product": "firefox", 21:08:38 INFO - "script_repo_revision": "production", 21:08:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:08:38 INFO - "repository": "", 21:08:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:08:38 INFO - "buildid": "20170423203420", 21:08:38 INFO - "pgo_build": "False", 21:08:38 INFO - "basedir": "/builds/slave/test", 21:08:38 INFO - "buildnumber": 85, 21:08:38 INFO - "slavename": "t-yosemite-r7-0057", 21:08:38 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:08:38 INFO - "platform": "yosemite_r7", 21:08:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:08:38 INFO - "branch": "mozilla-central", 21:08:38 INFO - "repo_path": "mozilla-central", 21:08:38 INFO - "revision": "933ced9c93e90cd1987c6b5f08dbada24eb2b781", 21:08:38 INFO - "stage_platform": "macosx64", 21:08:38 INFO - "builduid": "cc0f1a6afd1440dda35aaeef4181e51e", 21:08:38 INFO - "slavebuilddir": "test" 21:08:38 INFO - } 21:08:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 21:08:38 INFO - Running post-action listener: _resource_record_post_action 21:08:38 INFO - [mozharness: 2017-04-24 04:08:38.028181Z] Finished read-buildbot-config step (success) 21:08:38 INFO - [mozharness: 2017-04-24 04:08:38.028390Z] Running download-and-extract step. 21:08:38 INFO - Running pre-action listener: _resource_record_pre_action 21:08:38 INFO - Running main action method: download_and_extract 21:08:38 INFO - mkdir: /builds/slave/test/build/tests 21:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:38 INFO - trying https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 21:08:38 INFO - Downloading https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 21:08:39 INFO - Downloaded 1325 bytes. 21:08:39 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 21:08:39 INFO - Using the following test package requirements: 21:08:39 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 21:08:39 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:08:39 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 21:08:39 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 21:08:39 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'jsshell-mac.zip'], 21:08:39 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 21:08:39 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 21:08:39 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 21:08:39 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 21:08:39 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 21:08:39 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 21:08:39 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 21:08:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:08:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:08:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:08:39 INFO - Fetch https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:08:41 INFO - Content-Length response header: 52522857 21:08:41 INFO - Bytes received: 52522857 21:08:57 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:08:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 21:08:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:08:57 INFO - Fetch https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 21:08:59 INFO - Content-Length response header: 52522857 21:08:59 INFO - Bytes received: 52522857 21:09:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 21:09:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:09:14 INFO - Fetch https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 21:09:15 INFO - Content-Length response header: 14408822 21:09:15 INFO - Bytes received: 14408822 21:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:15 INFO - trying https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:09:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 21:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 21:09:17 INFO - Downloaded 71039877 bytes. 21:09:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:09:17 INFO - mkdir: /builds/slave/test/properties 21:09:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:09:17 INFO - Writing to file /builds/slave/test/properties/build_url 21:09:17 INFO - Contents: 21:09:17 INFO - build_url:https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 21:09:18 INFO - Running post-action listener: _resource_record_post_action 21:09:18 INFO - Running post-action listener: set_extra_try_arguments 21:09:18 INFO - [mozharness: 2017-04-24 04:09:18.346481Z] Finished download-and-extract step (success) 21:09:18 INFO - [mozharness: 2017-04-24 04:09:18.346606Z] Running populate-webroot step. 21:09:18 INFO - Running pre-action listener: _resource_record_pre_action 21:09:18 INFO - Running main action method: populate_webroot 21:09:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:09:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:09:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:09:18 INFO - '--tppagecycles', 21:09:18 INFO - '7'], 21:09:18 INFO - 'tests': ['tsvgm']}}, 21:09:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:09:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:09:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:09:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:09:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:09:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['damp', 'tps']}, 21:09:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'tests': ['damp', 'tps']}, 21:09:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['dromaeo_dom']}, 21:09:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:09:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:09:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:09:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['a11yr', 21:09:18 INFO - 'ts_paint', 21:09:18 INFO - 'tpaint', 21:09:18 INFO - 'sessionrestore', 21:09:18 INFO - 'sessionrestore_no_auto_restore', 21:09:18 INFO - 'tabpaint']}, 21:09:18 INFO - 'other-e10s': {'tests': ['a11yr', 21:09:18 INFO - 'ts_paint', 21:09:18 INFO - 'tpaint', 21:09:18 INFO - 'sessionrestore', 21:09:18 INFO - 'sessionrestore_no_auto_restore', 21:09:18 INFO - 'tabpaint']}, 21:09:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:09:18 INFO - 'ts_paint', 21:09:18 INFO - 'tpaint', 21:09:18 INFO - 'sessionrestore', 21:09:18 INFO - 'sessionrestore_no_auto_restore', 21:09:18 INFO - 'tabpaint']}, 21:09:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:09:18 INFO - 'ts_paint', 21:09:18 INFO - 'tpaint', 21:09:18 INFO - 'sessionrestore', 21:09:18 INFO - 'sessionrestore_no_auto_restore', 21:09:18 INFO - 'tabpaint']}, 21:09:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['a11yr', 21:09:18 INFO - 'ts_paint', 21:09:18 INFO - 'tpaint', 21:09:18 INFO - 'sessionrestore', 21:09:18 INFO - 'sessionrestore_no_auto_restore', 21:09:18 INFO - 'tabpaint']}, 21:09:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['a11yr', 21:09:18 INFO - 'ts_paint', 21:09:18 INFO - 'tpaint', 21:09:18 INFO - 'sessionrestore', 21:09:18 INFO - 'sessionrestore_no_auto_restore', 21:09:18 INFO - 'tabpaint']}, 21:09:18 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:09:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:09:18 INFO - 'bloom_basic_ref']}, 21:09:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['tsvgx', 21:09:18 INFO - 'tsvgr_opacity', 21:09:18 INFO - 'tart', 21:09:18 INFO - 'tscrollx', 21:09:18 INFO - 'cart', 21:09:18 INFO - 'tsvg_static']}, 21:09:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:09:18 INFO - 'tsvgr_opacity', 21:09:18 INFO - 'tart', 21:09:18 INFO - 'tscrollx', 21:09:18 INFO - 'cart', 21:09:18 INFO - 'tsvg_static']}, 21:09:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'talos_options': ['--disable-e10s'], 21:09:18 INFO - 'tests': ['tp5o']}, 21:09:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:09:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'talos_options': ['--disable-e10s', 21:09:18 INFO - '--xperf_path', 21:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:18 INFO - 'tests': ['tp5n']}, 21:09:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:09:18 INFO - 'talos_options': ['--xperf_path', 21:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:09:18 INFO - 'tests': ['tp5n']}}, 21:09:18 INFO - 'talos.zip': {'path': '', 21:09:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:09:18 INFO - Running post-action listener: _resource_record_post_action 21:09:18 INFO - [mozharness: 2017-04-24 04:09:18.365995Z] Finished populate-webroot step (success) 21:09:18 INFO - [mozharness: 2017-04-24 04:09:18.366133Z] Running create-virtualenv step. 21:09:18 INFO - Running pre-action listener: _resource_record_pre_action 21:09:18 INFO - Running main action method: create_virtualenv 21:09:18 INFO - Creating virtualenv /builds/slave/test/build/venv 21:09:18 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 21:09:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:09:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:09:18 INFO - Using real prefix '/tools/python27' 21:09:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:09:19 INFO - Installing distribute.............................................................................................................................................................................................done. 21:09:22 INFO - Installing pip.................done. 21:09:22 INFO - Return code: 0 21:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:09:22 INFO - Reading from file tmpfile_stdout 21:09:22 INFO - Output received: 21:09:22 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) 21:09:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:22 INFO - 'HOME': '/Users/cltbld', 21:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:22 INFO - 'LOGNAME': 'cltbld', 21:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:22 INFO - 'MOZ_NO_REMOTE': '1', 21:09:22 INFO - 'NO_EM_RESTART': '1', 21:09:22 INFO - 'PAGER': '/bin/cat', 21:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:22 INFO - 'PWD': '/builds/slave/test', 21:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:22 INFO - 'SHELL': '/bin/bash', 21:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:22 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:22 INFO - 'USER': 'cltbld', 21:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:22 INFO - 'XPC_FLAGS': '0x0', 21:09:22 INFO - 'XPC_SERVICE_NAME': '0', 21:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:22 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 21:09:22 INFO - Cleaning up... 21:09:22 INFO - Return code: 0 21:09:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:22 INFO - 'HOME': '/Users/cltbld', 21:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:22 INFO - 'LOGNAME': 'cltbld', 21:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:22 INFO - 'MOZ_NO_REMOTE': '1', 21:09:22 INFO - 'NO_EM_RESTART': '1', 21:09:22 INFO - 'PAGER': '/bin/cat', 21:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:22 INFO - 'PWD': '/builds/slave/test', 21:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:22 INFO - 'SHELL': '/bin/bash', 21:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:22 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:22 INFO - 'USER': 'cltbld', 21:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:22 INFO - 'XPC_FLAGS': '0x0', 21:09:22 INFO - 'XPC_SERVICE_NAME': '0', 21:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:22 INFO - Downloading/unpacking psutil>=3.1.1 21:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:09:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:27 INFO - Installing collected packages: psutil 21:09:27 INFO - Running setup.py install for psutil 21:09:27 INFO - building 'psutil._psutil_osx' extension 21:09:27 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 21:09:27 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 21:09:27 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 21:09:27 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 21:09:27 INFO - building 'psutil._psutil_posix' extension 21:09:27 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 21:09:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:09:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:09:27 INFO - ^ 21:09:28 INFO - 1 warning generated. 21:09:28 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 21:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:28 INFO - Successfully installed psutil 21:09:28 INFO - Cleaning up... 21:09:28 INFO - Return code: 0 21:09:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:09:28 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')]} 21:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:28 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')]} 21:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:28 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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:28 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 21:09:28 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 21:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:28 INFO - 'HOME': '/Users/cltbld', 21:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:28 INFO - 'LOGNAME': 'cltbld', 21:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:28 INFO - 'MOZ_NO_REMOTE': '1', 21:09:28 INFO - 'NO_EM_RESTART': '1', 21:09:28 INFO - 'PAGER': '/bin/cat', 21:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:28 INFO - 'PWD': '/builds/slave/test', 21:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:28 INFO - 'SHELL': '/bin/bash', 21:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:28 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:28 INFO - 'USER': 'cltbld', 21:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:28 INFO - 'XPC_FLAGS': '0x0', 21:09:28 INFO - 'XPC_SERVICE_NAME': '0', 21:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:09:28 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 21:09:28 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 21:09:28 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 21:09:28 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 21:09:28 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 21:09:28 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 21:09:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:09:31 INFO - Installing collected packages: mozsystemmonitor 21:09:31 INFO - Running setup.py install for mozsystemmonitor 21:09:31 INFO - Successfully installed mozsystemmonitor 21:09:31 INFO - Cleaning up... 21:09:31 INFO - Return code: 0 21:09:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:09:31 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')]} 21:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:31 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')]} 21:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:31 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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:31 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 21:09:31 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 21:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:31 INFO - 'HOME': '/Users/cltbld', 21:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:31 INFO - 'LOGNAME': 'cltbld', 21:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:31 INFO - 'MOZ_NO_REMOTE': '1', 21:09:31 INFO - 'NO_EM_RESTART': '1', 21:09:31 INFO - 'PAGER': '/bin/cat', 21:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:31 INFO - 'PWD': '/builds/slave/test', 21:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:31 INFO - 'SHELL': '/bin/bash', 21:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:31 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:31 INFO - 'USER': 'cltbld', 21:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:31 INFO - 'XPC_FLAGS': '0x0', 21:09:31 INFO - 'XPC_SERVICE_NAME': '0', 21:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:31 INFO - Downloading/unpacking jsonschema==2.5.1 21:09:31 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 21:09:31 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 21:09:31 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 21:09:31 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 21:09:31 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 21:09:31 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 21:09:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:09:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:34 INFO - Downloading functools32-3.2.3-2.tar.gz 21:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:09:34 INFO - warning: no files found matching '*.txt' 21:09:34 INFO - no previously-included directories found matching 'build' 21:09:34 INFO - no previously-included directories found matching 'dist' 21:09:34 INFO - no previously-included directories found matching '.git*' 21:09:34 INFO - Installing collected packages: jsonschema, functools32 21:09:34 INFO - Running setup.py install for functools32 21:09:34 INFO - warning: no files found matching '*.txt' 21:09:34 INFO - no previously-included directories found matching 'build' 21:09:34 INFO - no previously-included directories found matching 'dist' 21:09:34 INFO - no previously-included directories found matching '.git*' 21:09:35 INFO - Successfully installed jsonschema functools32 21:09:35 INFO - Cleaning up... 21:09:35 INFO - Return code: 0 21:09:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:35 INFO - 'HOME': '/Users/cltbld', 21:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:35 INFO - 'LOGNAME': 'cltbld', 21:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:35 INFO - 'MOZ_NO_REMOTE': '1', 21:09:35 INFO - 'NO_EM_RESTART': '1', 21:09:35 INFO - 'PAGER': '/bin/cat', 21:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:35 INFO - 'PWD': '/builds/slave/test', 21:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:35 INFO - 'SHELL': '/bin/bash', 21:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:35 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:35 INFO - 'USER': 'cltbld', 21:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:35 INFO - 'XPC_FLAGS': '0x0', 21:09:35 INFO - 'XPC_SERVICE_NAME': '0', 21:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:09:35 INFO - Cleaning up... 21:09:35 INFO - Return code: 0 21:09:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:35 INFO - 'HOME': '/Users/cltbld', 21:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:35 INFO - 'LOGNAME': 'cltbld', 21:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:35 INFO - 'MOZ_NO_REMOTE': '1', 21:09:35 INFO - 'NO_EM_RESTART': '1', 21:09:35 INFO - 'PAGER': '/bin/cat', 21:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:35 INFO - 'PWD': '/builds/slave/test', 21:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:35 INFO - 'SHELL': '/bin/bash', 21:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:35 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:35 INFO - 'USER': 'cltbld', 21:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:35 INFO - 'XPC_FLAGS': '0x0', 21:09:35 INFO - 'XPC_SERVICE_NAME': '0', 21:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:35 INFO - Downloading/unpacking blobuploader==1.2.4 21:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:38 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:38 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 21:09:38 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 21:09:38 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 21:09:38 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 21:09:38 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 21:09:38 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 21:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:39 INFO - Downloading docopt-0.6.1.tar.gz 21:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:39 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:39 INFO - Running setup.py install for blobuploader 21:09:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:39 INFO - Running setup.py install for requests 21:09:40 INFO - Running setup.py install for docopt 21:09:40 INFO - Successfully installed blobuploader requests docopt 21:09:40 INFO - Cleaning up... 21:09:40 INFO - Return code: 0 21:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:40 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')]} 21:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:40 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')]} 21:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:40 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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:40 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 21:09:40 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 21:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:40 INFO - 'HOME': '/Users/cltbld', 21:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:40 INFO - 'LOGNAME': 'cltbld', 21:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:40 INFO - 'MOZ_NO_REMOTE': '1', 21:09:40 INFO - 'NO_EM_RESTART': '1', 21:09:40 INFO - 'PAGER': '/bin/cat', 21:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:40 INFO - 'PWD': '/builds/slave/test', 21:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:40 INFO - 'SHELL': '/bin/bash', 21:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:40 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:40 INFO - 'USER': 'cltbld', 21:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:40 INFO - 'XPC_FLAGS': '0x0', 21:09:40 INFO - 'XPC_SERVICE_NAME': '0', 21:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:40 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-sNLJCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:40 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-bf7nOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:40 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-dmrdsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-78al1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-WpJUFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-BLwbfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-tEIeZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-wVlVDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-1h9FGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-SHap49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-o3OLQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-hTGETt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:41 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-JF9JaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:42 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-AJpmwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:42 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-H8awur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:42 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-UpBR3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:42 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-82XKFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:42 INFO - Running setup.py install for manifestparser 21:09:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:42 INFO - Running setup.py install for mozcrash 21:09:42 INFO - Running setup.py install for mozdebug 21:09:42 INFO - Running setup.py install for mozdevice 21:09:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Running setup.py install for mozfile 21:09:43 INFO - Running setup.py install for mozhttpd 21:09:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Running setup.py install for mozinfo 21:09:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Running setup.py install for mozInstall 21:09:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Running setup.py install for mozleak 21:09:43 INFO - Running setup.py install for mozlog 21:09:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:43 INFO - Running setup.py install for moznetwork 21:09:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:44 INFO - Running setup.py install for mozprocess 21:09:44 INFO - Running setup.py install for mozprofile 21:09:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:44 INFO - Running setup.py install for mozrunner 21:09:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:44 INFO - Running setup.py install for mozscreenshot 21:09:44 INFO - Running setup.py install for moztest 21:09:44 INFO - Running setup.py install for mozversion 21:09:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:45 INFO - Cleaning up... 21:09:45 INFO - Return code: 0 21:09:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:45 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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:45 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 21:09:45 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 21:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:45 INFO - 'HOME': '/Users/cltbld', 21:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:45 INFO - 'LOGNAME': 'cltbld', 21:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:45 INFO - 'MOZ_NO_REMOTE': '1', 21:09:45 INFO - 'NO_EM_RESTART': '1', 21:09:45 INFO - 'PAGER': '/bin/cat', 21:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:45 INFO - 'PWD': '/builds/slave/test', 21:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:45 INFO - 'SHELL': '/bin/bash', 21:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:45 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:45 INFO - 'USER': 'cltbld', 21:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:45 INFO - 'XPC_FLAGS': '0x0', 21:09:45 INFO - 'XPC_SERVICE_NAME': '0', 21:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-BiyCeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:45 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)) 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-QLNp5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:45 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)) 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-U8m2dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:45 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)) 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-ueaWtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-tV3P4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:45 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)) 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-XDsRsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:45 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)) 21:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:45 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-NQTnOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-TFDwR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-NtAWGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-yOYWmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Tq_Gva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-XjGeLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-qvYxuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-VvTyhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-tkPS89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:46 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)) 21:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:46 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-fG9AtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:47 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)) 21:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:47 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-d6sxTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:47 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)) 21:09:47 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)) 21:09:47 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)) 21:09:47 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)) 21:09:47 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:47 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:09:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:49 INFO - Downloading blessings-1.6.tar.gz 21:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:49 INFO - Installing collected packages: blessings 21:09:49 INFO - Running setup.py install for blessings 21:09:50 INFO - Successfully installed blessings 21:09:50 INFO - Cleaning up... 21:09:50 INFO - Return code: 0 21:09:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:50 INFO - Reading from file tmpfile_stdout 21:09:50 INFO - Current package versions: 21:09:50 INFO - blessings == 1.6 21:09:50 INFO - blobuploader == 1.2.4 21:09:50 INFO - docopt == 0.6.1 21:09:50 INFO - functools32 == 3.2.3-2 21:09:50 INFO - jsonschema == 2.5.1 21:09:50 INFO - manifestparser == 1.1 21:09:50 INFO - mozInstall == 1.12 21:09:50 INFO - mozcrash == 1.0 21:09:50 INFO - mozdebug == 0.1 21:09:50 INFO - mozdevice == 0.50 21:09:50 INFO - mozfile == 1.2 21:09:50 INFO - mozhttpd == 0.7 21:09:50 INFO - mozinfo == 0.9 21:09:50 INFO - mozleak == 0.1 21:09:50 INFO - mozlog == 3.4 21:09:50 INFO - moznetwork == 0.27 21:09:50 INFO - mozprocess == 0.25 21:09:50 INFO - mozprofile == 0.28 21:09:50 INFO - mozrunner == 6.13 21:09:50 INFO - mozscreenshot == 0.1 21:09:50 INFO - mozsystemmonitor == 0.3 21:09:50 INFO - moztest == 0.8 21:09:50 INFO - mozversion == 1.4 21:09:50 INFO - psutil == 3.1.1 21:09:50 INFO - requests == 1.2.3 21:09:50 INFO - wsgiref == 0.1.2 21:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:50 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')]} 21:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:50 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')]} 21:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:50 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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:50 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 21:09:50 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 21:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:50 INFO - 'HOME': '/Users/cltbld', 21:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:50 INFO - 'LOGNAME': 'cltbld', 21:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:50 INFO - 'MOZ_NO_REMOTE': '1', 21:09:50 INFO - 'NO_EM_RESTART': '1', 21:09:50 INFO - 'PAGER': '/bin/cat', 21:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:50 INFO - 'PWD': '/builds/slave/test', 21:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:50 INFO - 'SHELL': '/bin/bash', 21:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:50 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:50 INFO - 'USER': 'cltbld', 21:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:50 INFO - 'XPC_FLAGS': '0x0', 21:09:50 INFO - 'XPC_SERVICE_NAME': '0', 21:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 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)) 21:09:50 INFO - Cleaning up... 21:09:50 INFO - Return code: 0 21:09:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:09:50 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')]} 21:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:50 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')]} 21:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:50 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 0x1056f4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056f7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98facb1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, '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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 21:09:50 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 21:09:50 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 21:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:09:50 INFO - 'HOME': '/Users/cltbld', 21:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:09:50 INFO - 'LOGNAME': 'cltbld', 21:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:50 INFO - 'MOZ_NO_REMOTE': '1', 21:09:50 INFO - 'NO_EM_RESTART': '1', 21:09:50 INFO - 'PAGER': '/bin/cat', 21:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:50 INFO - 'PWD': '/builds/slave/test', 21:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:09:50 INFO - 'SHELL': '/bin/bash', 21:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:09:50 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:09:50 INFO - 'USER': 'cltbld', 21:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:50 INFO - 'XPC_FLAGS': '0x0', 21:09:50 INFO - 'XPC_SERVICE_NAME': '0', 21:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:09:50 INFO - Cleaning up... 21:09:50 INFO - Return code: 0 21:09:50 INFO - Running post-action listener: _resource_record_post_action 21:09:50 INFO - Running post-action listener: _start_resource_monitoring 21:09:50 INFO - Starting resource monitoring. 21:09:50 INFO - [mozharness: 2017-04-24 04:09:50.960865Z] Finished create-virtualenv step (success) 21:09:50 INFO - [mozharness: 2017-04-24 04:09:50.961845Z] Running install step. 21:09:50 INFO - Running pre-action listener: _resource_record_pre_action 21:09:50 INFO - Running main action method: install 21:09:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:51 INFO - Reading from file tmpfile_stdout 21:09:51 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:51 INFO - Reading from file tmpfile_stdout 21:09:51 INFO - Output received: 21:09:51 INFO - Usage: mozinstall [options] installer 21:09:51 INFO - Options: 21:09:51 INFO - -h, --help show this help message and exit 21:09:51 INFO - -d DEST, --destination=DEST 21:09:51 INFO - Directory to install application into. [default: 21:09:51 INFO - "/builds/slave/test"] 21:09:51 INFO - --app=APP Application being installed. [default: firefox] 21:09:51 INFO - mkdir: /builds/slave/test/build/application 21:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:10:10 INFO - Reading from file tmpfile_stdout 21:10:10 INFO - Output received: 21:10:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:10:10 INFO - Running post-action listener: _resource_record_post_action 21:10:10 INFO - [mozharness: 2017-04-24 04:10:10.764559Z] Finished install step (success) 21:10:10 INFO - [mozharness: 2017-04-24 04:10:10.764717Z] Running run-tests step. 21:10:10 INFO - Running pre-action listener: _resource_record_pre_action 21:10:10 INFO - Running main action method: run_tests 21:10:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:10:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:10:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:10:10 INFO - 2017-04-23 21:10:10.779 screenresolution[1629:8278] starting screenresolution argv=screenresolution get 21:10:10 INFO - 2017-04-23 21:10:10.781 screenresolution[1629:8278] Display 0: 1600x1200x32@60 21:10:10 INFO - 2017-04-23 21:10:10.787 screenresolution[1630:8281] starting screenresolution argv=screenresolution list 21:10:10 INFO - Available Modes on Display 0 21:10:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:10:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:10:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:10:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:10:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:10:11 INFO - Intel Iris: 21:10:11 INFO - Chipset Model: Intel Iris 21:10:11 INFO - Type: GPU 21:10:11 INFO - Bus: Built-In 21:10:11 INFO - VRAM (Dynamic, Max): 1536 MB 21:10:11 INFO - Vendor: Intel (0x8086) 21:10:11 INFO - Device ID: 0x0a2e 21:10:11 INFO - Revision ID: 0x0009 21:10:11 INFO - Displays: 21:10:11 INFO - Display: 21:10:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:10:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:10:11 INFO - Display Serial Number: 1600x1200 60 21:10:11 INFO - Main Display: Yes 21:10:11 INFO - Mirror: Off 21:10:11 INFO - Online: Yes 21:10:11 INFO - Rotation: Supported 21:10:11 INFO - Return code: 0 21:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:10:11 INFO - Python 2.7.3 21:10:11 INFO - Return code: 0 21:10:11 INFO - grabbing minidump binary from tooltool 21:10: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')]} 21:10:11 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 0x1054d2d30>, '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 0x1053f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054c7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:10:11 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 21:10:11 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 21:10:11 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 21:10:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:10:11 INFO - Return code: 0 21:10:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:10:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:10:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:10:11 INFO - ENV: RUST_BACKTRACE is now 1 21:10:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:10:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 21:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --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 21:10:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L4kfAUB1bY/Render', 21:10:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:11 INFO - 'HOME': '/Users/cltbld', 21:10:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:11 INFO - 'LOGNAME': 'cltbld', 21:10:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:10:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:11 INFO - 'MOZ_NO_REMOTE': '1', 21:10:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:10:11 INFO - 'NO_EM_RESTART': '1', 21:10:11 INFO - 'PAGER': '/bin/cat', 21:10:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:11 INFO - 'PWD': '/builds/slave/test', 21:10:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:10:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:11 INFO - 'RUST_BACKTRACE': '1', 21:10:11 INFO - 'SHELL': '/bin/bash', 21:10:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HUm0vHbYBk/Listeners', 21:10:11 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 21:10:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:11 INFO - 'USER': 'cltbld', 21:10:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:11 INFO - 'XPC_FLAGS': '0x0', 21:10:11 INFO - 'XPC_SERVICE_NAME': '0', 21:10:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 21:10:11 INFO - mozversion application_buildid: 20170423203420 21:10:11 INFO - mozversion application_changeset: 933ced9c93e90cd1987c6b5f08dbada24eb2b781 21:10:11 INFO - mozversion application_display_name: Nightly 21:10:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:10:11 INFO - mozversion application_name: Firefox 21:10:11 INFO - mozversion application_remotingname: firefox 21:10:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:10:11 INFO - mozversion application_vendor: Mozilla 21:10:11 INFO - mozversion application_version: 55.0a1 21:10:11 INFO - mozversion platform_buildid: 20170423203420 21:10:11 INFO - mozversion platform_changeset: 933ced9c93e90cd1987c6b5f08dbada24eb2b781 21:10:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:10:11 INFO - mozversion platform_version: 55.0a1 21:10:11 INFO - using testdate: 1493007011 21:10:11 INFO - actual date: 1493007011 21:10:11 INFO - starting webserver on 'localhost:49235' 21:10:11 INFO - SUITE-START | Running 2 tests 21:10:11 INFO - TEST-START | dromaeo_css 21:10:11 INFO - operating with platform_type : mac_ 21:10:11 INFO - Initialising browser for dromaeo_css test... 21:10:11 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpyjKVem/profile http://localhost:49235/getInfo.html) 21:10:14 INFO - PID 1640 | __metrics Screen width/height:1600/1200 21:10:14 INFO - PID 1640 | colorDepth:24 21:10:14 INFO - PID 1640 | Browser inner width/height: 1024/689 21:10:14 INFO - PID 1640 | __metrics 21:10:14 INFO - PID 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:10:14 INFO - PID 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:10:15 INFO - TEST-INFO | 1640: exit 0 21:10:15 INFO - Browser initialized. 21:10:15 INFO - Running cycle 1/1 for dromaeo_css test... 21:10:15 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpyjKVem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:10:27 INFO - PID 1643 | RSS: Main: 242692096 21:10:27 INFO - PID 1643 | 21:13:32 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 21:13:33 INFO - PID 1643 | RSS: Main: 401661952 21:13:33 INFO - PID 1643 | 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 21:15:16 INFO - PID 1643 | 21:15:16 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:15:16 INFO - PID 1643 | Full stack: 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 21:15:16 INFO - PID 1643 | 21:15:16 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:15:16 INFO - PID 1643 | Full stack: 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 21:15:16 INFO - PID 1643 | 21:15:16 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:15:16 INFO - PID 1643 | Full stack: 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | ************************* 21:15:16 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 21:15:16 INFO - PID 1643 | 21:15:16 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:15:16 INFO - PID 1643 | Full stack: 21:15:16 INFO - PID 1643 | ************************* 21:16:36 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 21:16:37 INFO - PID 1643 | RSS: Main: 371527680 21:16:37 INFO - PID 1643 | 21:19:39 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 21:19:39 INFO - PID 1643 | RSS: Main: 338972672 21:19:39 INFO - PID 1643 | 21:22:42 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 21:22:42 INFO - PID 1643 | RSS: Main: 326025216 21:22:42 INFO - PID 1643 | 21:25:46 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 21:25:46 INFO - PID 1643 | RSS: Main: 337477632 21:25:46 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 21:28:49 INFO - PID 1643 | RSS: Main: 372232192 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | __start_tp_report 21:28:49 INFO - PID 1643 | _x_x_mozilla_page_load 21:28:49 INFO - PID 1643 | _x_x_mozilla_page_load_details 21:28:49 INFO - PID 1643 | |i|pagename|runs| 21:28:49 INFO - PID 1643 | |0;dojo.html;3246.204679853436;3391;3436.7250619950405;3527.629598892117;3565.554305711786;5937.317208521022;6125.693715314228;6164.137020817084;6164.167837341957;6188.845278868031;5445.918311225335;5757.856053598652;6015.0676645120075;6087.756489740405;6119.7246123924415;5238.00477909198;5270.894582108374;5273.261743355914;5316.149416093426;5367.221752845835;5356.3572371315495;5375.489328513804;5377.059014672436;5377.139657654776;5389.676619402829;5356.946430535703;5361.624686271963;5366.168243922199;5372.382176049765;5380.192971054354;5373.167159090347;5374.785008599671;5378.058839703036;5389.946100539023;5403.189521571757;5286.709230992294;5326.467353264643;5326.653767505139;5340.786368545254;5362.6782393056155;6201.844953876144;6219.471344935686;6220.813375598739;6225.564210505267;6266.717997690115;6305.274893387274;6529.4123528882155;6547.377999090127;6587.80236592903;6595.373439523238;6443.452306553949;6453.16108905844;6455.257645370749;6462.612243265419;6466.191726034246;5663.263775709132;6177.073438984188;6222.62664240138;6229.7508099676415;6232.844178895564;6747.662616869137;6773.966130169416;6782.626955517494;6790.1851777786;6794.218664853605;6454.386833250834;6456.580322279036;6465.515086368541;6468.708908099147;6482.286948435668;6345.270293916259;6372.745090196433;6511.739530418825;6550.803475895731;6626.9337306627285;6517.152770139852;6536.182977127859;6545.345465453416;6548.967255163789;6550.115734375893;6486.383793539606;6520.0871877937125;6542.738290468328;6550.737970481127;6557.803265902031;5118.38579370478;5207.37511498615;5220.190870415092;5238.7904483820985;5253.947460525423;4675.345451636774;4701.623870090384;4703.482616912137;4716.245400735866;4729.574338309569;6150.815475535741;6162.445379915829;6166.599171053867;6169.537284703665;6190.442860142609;6287.559870809091;6435.935640643534;6617.602943823386;6643.2028156620545;6650.767223147167;6118.010103775246;6151.384861513902;6163;6181.320054793969;6188;5754.395788442237;5763.423657634287;5764.827055188351;5770;5780.826575202751;6525.2169739631545;6773.221079575912;6831.4534837212905;6845.110135682329;6851.3491218334175;6337.081123237012;6568.9014664781025;6639.6680165992475;6650.567713098633;6652.2349929756765;5519.613627046228;6329.335419780857;6800.625965571743;6803.625800581016;6833.521653484208;6441.355864413708;6497.74009039652;6505.577137486048;6511.967440162769;6512.446442052478;5248.317718696545;6329.968350158219;6377.330380310186;6441.516886233458;6637.933620663732;6366.108744775827;6368.108464814837;6373.7131829066875;6380.617162970237;6387.744490220339;6232.875342493216;6267.122602835698;6329.841753956188;6389.93610063912;6406.135171751754;6255.56211065221;6268.937310626835;6289.276733175743;6310.400511951358;6314.368563143649;6363.713632886439;6389.648569328546;6407.871842563216;6413.102165696713;6419.614823110628;6306.4639505642535;6317.9052314214405;6320.462760665211;6330;6339.683015849281 21:28:49 INFO - PID 1643 | |1;ext.html;745.8843879198727;789.5539020453443;800.4036992440632;1106.170372220835;1121.0639116337868;26485.337866553346;26996.730032699666;27005;27015.594766078477;27034.783434745434;26745.331366715844;28165.85917070412;37443;37980.923052311635;38055.42916856249;7297;8010.118886922434;8331.62507687154;8442.915570844274;8492.490450572954;8240.876386854203;8365.498070115782;8370.204830541119;8373.455725377862;8375.455595386311;5913.852153696149;6069.30203026651;8249.628766705482;8408.621612027442;8426.957865210665;8366.53984030878;8434.57827108642;8435.427194705613;8448.155184481564;8463.322934165282;8201.71294004713;8280.213379728915;8282.42023058386;8290.626921788535;8290.917090829134;25440.872795635903;25599.61600575993;35994.64005359939;36464.453033204525;36493;3558.6085530591613;3577.4454959481322;3586.1393265616325;3586.282743451294;3587.6950459211;30457.086287411414;30502.694973050206;30517.847410762803;30544.847275763477;30577.08268751941;3096.4890793019126;3136.4824803907327;3154.0853152585723;3159.210197450637;3167.224030112637;295450.52274738706;297689;298829;299153.00846991467;300178;48710.51289487131;48811.85099266531;48831.51168488341;48865.7783555414;48960.51039489631;50807.23789143166;50831;50853.491465085615;50894.23658645123;50926.23610645843;13875;13986.510472133426;14032.017758756789;14043;14049.227292498806;11431.371274579978;11437.714057148638;11439.828402573969;11453.828192577119;11467.942660286812;10427.217958653131;12127.33299668509;12319.137660363689;12376.143578463303;12453.25280483174;4867.805287788448;4879.804807807648;4892.2661600760175;4892.8532144035735;4894.608431325485;974.7904200596905;985.8964808695127;997.2072202598952;1010.6406882742699;1018.7096677446892;23871.522569548513;24065.51868962611;24102.87948560246;24133.155339563033;24165.033398664207;1093.748437859281;1104.745908441063;1140.4297851074464;1144.891235332642;1146.140394703972;11131.833022504668;12370.505179792888;12370.938145309216;12412.751744965231;12421.44103515344;229811;290863;292669;293082;293138;51455.71360715937;51617.48382516127;51620.74189629028;51757;51799;1452.3899962015978;1485.0569888120906;1500.7373709600777;1502.2713983717888;1505.6913332766976;27594;27904.860475697493;28488.715112849437;28549.571756423255;28674.56988145221;35376.29247414986;35465.64534354623;35522.99999999897;35542;35618.28763424769;255884;256477;256626;257536;257559.42440576103;30924;31090.378192436478;31091.37817243688;31105.533416999217;31110.91111811076;43971.78014109909;44141.11717765562;44154;44157.77921110374;44182.33726494169;25176.496470070862;26432.735672643026;26601.467970640093;30502.62738176743;30704.846475768372;29656;29713.25716857096;30278.84860575683;30481.237969050064;30587.694123058485;36376.81811590925;36743.26513469662;36763.816180918926;36801.447978279815;36913.630863692095;28812.279693007004;29464.410711785215;29722.554161688025;30699.9255026073;30979.69020309768;20082.39390663633;21938.451538711022;22417;24052.51894962126;24325.878370608032 21:28:49 INFO - PID 1643 | |2;jquery.html;437.5252850657037;439.18969501270146;439.92081425343434;445.2764258080619;457.69563240445126;20780.792192078094;21481.03335349909;21522.461938451528;21980.450488737788;22220.666689999664;21731.782682173172;22240.888795556;22825.85870706462;22872.885635571798;23069.884650576725;5256;5825.970870145643;6231.8753624927585;6461.547691661585;6463.903041454382;6223.813285601439;6385.712642931079;6388.073729309247;6391.424771770539;6394.872102557946;5550.306211723535;5984.88030239395;6293.087502312162;6327.177466929293;6350.047492876082;6185.474234690057;6293.590916590453;6296.055591661242;6316.210473690789;6317.1156038154695;5400.459954004607;5550.500454959033;5612.887742245173;5619.831405057814;5621.662700237999;23962.40093997664;26988;27135.592966105523;27191.592126118125;27284.454310913672;2038.3681058871798;2215.2246713650256;2217.135317226283;2218.3123231798195;2221.2891874600136;17820.287188512444;17838.732419013726;18096.18567164481;18110;18121.09394530268;2128.3402145334994;2128.8509804313703;2167.837412194076;2171.9891400543056;2173.1307477009163;154083.52540610262;159748;159932;161891.38108619;163699.1815040917;11140.554377824958;12033.518659253707;12103.152779305365;12333.691657708629;12483.812742808865;13857.792133118011;16516.669666606602;16547.007179569264;16570;16599.6680066398;8529.488230706178;8826.249768769727;8851.380403371832;8976.192142707188;8993.190612844875;7501.249875012564;8069.9596502018285;8373.246407823324;8415.158484151658;8572.785680358042;6578.76974305897;7712.994621398477;7789.260020298063;7847.803804904923;7864.449488535862;1737.904415257173;2120.787921207867;2140.989295053546;2148.2481131604127;2308.5036717105904;815.2214635023538;970.5632465390603;971.5725080964353;1006.1699098243978;1009.1573536097294;19937.102830372667;20966.685499717212;21215.469613259484;21357.893210533846;21706.240281590068;893.7710647859194;982.1455333859587;1010.8938561451089;1017.6845177994697;1025.1849779425374;9641.325107242566;9658.75853103664;10544.841827372595;10556.049955504042;11064.668059958214;527791;531472;561325;568973;571712;70440.64779676069;123787;124176;135491.3225433886;135584;1109.672646569264;1191.5889018288676;1235.7034311765112;1260.602910083321;1262.9936850315873;16463.60059394965;20339.8983005084;22235.110595576643;22690.20584279542;22820.543589128458;54007;54276.72861635667;54279.45720542902;56756.71621641865;57366.7131664339;59537.70231148817;74816;75680.24319756732;76869;78043.04892377736;10520.368777873353;12605.054620903285;12686.936565317483;13010.21938683682;13039;13778.517751878637;13870.029097963046;13917.51288704931;14180.14919104857;14210.00529962934;11780.057595392176;11782;11949.940250299042;12036.097292702907;12150.513979441077;11098.389588572383;11121.944390277997;11170.944145279222;11562.132840036862;11575.363355015555;11616.709582260512;11797.29216247028;12091.334976576021;12091.939540302243;12210.572629958264;12483.75032499363;12518.374081295717;12819.102662813513;12840.807387889003;12868.549600763929;11823.172377933462;11923.284602923852;11941.46263418131;12046;12056.397180141134 21:28:49 INFO - PID 1643 | |3;mootools.html;1193.659806955018;1408.2747385096675;1443.841177470478;1464.952558920372;1466.457410758019;9711.271654625905;10206.030427109412;10217.897821021788;10229.744256393584;10236.43699596522;9850.753731156725;11260.43697815108;11574.53701851927;11581.36302503362;11583.18917675763;2494.1769216158714;2539.7079335876333;2540.9110681126162;2541.275736415122;2543.0844895837486;2114.164904862578;2374.25211058516;2513.258588716324;2514.4342522932284;2516.2954372775653;2151.9354419367446;2183;2460.458699086207;2535.518251532203;2536.73364296748;2462.6675398821108;2477.4797292568583;2488.7760101590943;2495.3262619092743;2502.9374265643323;2429.514097180571;2474.7648973347505;2478.2069737683946;2482.453860150764;2492.1526680928573;11683.941580292128;11788.764224715458;11802.704932376759;11803.822942655866;11816.586419475278;6395.328490508523;6639.966800166017;6642.900356494656;6655.900161497581;6672.232693240242;3816.1985982943615;3998.8400463981407;4160.479940007499;4163.875083747493;4166.64583510402;1062.9627963021335;1213.4842691855927;1221.309959872678;1253.7743206222876;1261.0794120292146;16705.749413758804;16761.91619041909;16772.496825095266;16777.66444671112;16808.915955420267;5764.827055188351;5915.585908986416;5954.880902382015;6060.666663333559;6101.481374083164;13797.172169669851;13808.240546770025;13816.825569826477;13842.377093030838;13852.614738526067;6618.404343609098;6740.325967403221;6741.157355330583;6753.425958793558;6764.3573860483175;6087.57386982907;6135.171751813537;6210.565260431817;6219.689015549295;6231.189945307172;4438.690586277056;4586.541345865387;4593.012502312019;4631.212693842055;4637.837675681335;1421.8791402730883;1435.8635929586674;1441.654003039263;1459.9270036498133;1469.8383177850642;648.1618920389868;652.5301782716436;741.3920585120258;764.0983639305562;770.7803276066406;6170.81487555374;6278.937210627835;6455.128557644752;6546.312637173123;6612.471002319803;829.8215883585058;858.8325276571134;929.2240978782658;940.0505489455562;942.5946842857637;3701;3979.4826672532963;4014.6186112319865;4015.1768887378016;4147.04617937876;14442.927785361217;15165.848341516665;15174.93775435731;15177.468788592567;15193.544193673986;12315.4458049388;14482.855171448151;15055;15060.849391506164;15118.319675614624;8290.295324897452;8499.065102838682;8532.104129066483;8535;8543.444676096035;6471;6821.488388370793;7016.19313778922;7030.824229394101;7082.504224704221;12874;12912.289824059766;12940.547080852126;13158.342082896008;13162.60512184636;10835.64554430696;13185.07704460717;13375.197488150741;13595.252261125337;13799.655008624462;9243.953780231324;9474.24206063527;9588.232941364813;9740.464274464972;9748.805023899624;11079;11200.551977921117;11217.439128043728;11223.775524489301;11224.989750922456;9077.319201059814;9291.907080929104;9300.953495232481;9392.718218453458;9399.295052870926;9059.048799875918;9216.95391523065;9224.769380765267;9238.030006849183;9357.251419886257;8116.675332986614;8303.252707256375;8309.418340716333;8319.41764076533;8322.37582181351;4970.558538023933;5290.709011004432;5357.544608708147;5935.584509084322;6202.255729312511;5782.161586570008;6025.18659980897;6071.301800292847;6072.696365181811;6363.172787537591 21:28:49 INFO - PID 1643 | |4;prototype.html;396.1166598485378;405.3736976371506;407.04750882933945;410.3946678648995;414.46120043942886;5269.86825329367;5950.256217972754;5993.831202915433;5994.370591087933;6006.4894483968865;4832.8884356598;5264.868378290545;5354.303940487741;5764.596478246524;5852.912206316909;4409.706952384758;4432.578905004019;4449.777511124447;4455.509893911667;4469.195544801934;4432.911341773162;4467.463904331468;4472.575105364985;4477.686561940665;4484.529124441936;4332.851685437746;4366.890827729317;4395.011122497429;4415.779211039435;4453.688241823057;3388.8136152511725;4407.338899165119;4409.426774519292;4417.3815665806815;4426.889327766816;3245.464498357768;3605.9542732607774;3944.1520073184115;3966.8809935701975;3967.662748666367;5491.36849262332;5672.8014519492035;5761.510271626917;5790;5795.146227758535;5309.734513274359;5313.997591360908;5343.3587969443915;5358.91961620576;5374.220737992969;6306.558540902139;6313.747450102036;6321.273053598849;6327.715252813588;6345.238571371465;4323.589259020388;4440.200763862504;4525.683202175849;4535.7732113394195;4546.704464209815;5658.292713410824;6025.367336429656;6456.644884531396;6474.935250647527;6536.93463065368;4270.572942705705;4449.83818770225;4456.286994080931;4461.460796025366;4462.642988560908;4042.8787136385954;4280.850170244026;4488.192125417391;4695.530446955346;4717.787699553528;5343.973280133574;5344.679319240858;5344.732763361816;5378.220158077057;5380.757865896044;5282.7622756976025;5717.542596592262;6071.423214794588;6338.112664227012;6352.777652782131;1346.4412268908488;1369.6301998460558;1606.5341051095052;1609.8390160983809;1611.7106314947994;928.8885333759993;1091.0230544727897;1117.463617463622;1120.6918097523082;1121.2095472691733;5625.324961004624;5801.564882633735;5826;5855.180274761537;5868.706564671749;5439.374471935699;6511.186101737283;6517.152770139852;6533.41199292066;6549.115869357671;5567.610267281251;5851.414858514115;5884.58807883444;5910.674912879746;5954.374790647006;3340.88306909257;3389.81356025416;3389.9152521187166;3400.013995941199;3403.50649155871;5621.7189140542805;6402.327755585689;6611.628069684495;6700.564463309869;6711.563748356341;6638.435732962752;6644.302348253461;6653.234877988996;6655.966720166368;6658.400743933069;5543.1685247213245;6548.476121910331;6657.933420665731;6726.630035348103;6733.696983635748;5945.483901605063;6037.486813620892;6435.839104022437;6449.774257900951;6471.188067341152;5757.36668966405;6383.691343274711;6398.584092034003;6413.262474815456;6451.806445806634;5558.805441809679;6332.493400528039;6649.501287403367;6693.933060669526;6695;3583.552055993001;4247.683218202367;4264.189803937242;4277.8288868444915;4288.14237152577;5091.490850914879;6222.253329600477;6421.853291887035;6467.482601391972;6490;5441.646292990943;6225.470834979077;6252.531060170414;6269.749210031548;6275.466585340298;5780.855478613068;5911.408859114054;6240.937590624036;6273.278572964167;6314.210723659543;4602.539746025371;5779.219805326227;5839.649621022582;6019.70576326092;6131.957567213495;6158.846028849135;6230.376962303733;6235.189425374672;6252.562320637512;6269.905951410641;5931.347551769388;5932.16949627044;6065.332813390612;6121.8980583495395;6131.172291740558 21:28:49 INFO - PID 1643 | |5;yui.html;693.7571849852549;791.4736700094437;838.5681374092344;842.5281842168382;850.8255807559449;12800.743985120303;17907;18244.81755182448;18274.54313642158;18292.268309267612;16497.67004659906;16655.16724163793;16657.33370665175;16667.583310417216;16703.83296167038;959.5490119643756;994.8109859126779;1001.849722541621;1009.3590569988073;1017.7964407118569;972.868662730533;982.6658935961772;993.3642468819961;995.1093771074884;1009.0111690543272;870.7387783664907;1042.3797840285056;1042.3849928542159;1045.8954104589518;1051.8842927277992;1031.7678522332415;1034.5396298647106;1035.5495359518634;1039.1634734039096;1040.9323393979366;779.99770295171;783.475071701961;783.5925318834231;784.0317208247809;786.1509569664748;13638;16045.438409655722;16281;16443.506694799176;16626.58433539171;16425.26086326118;16496.42262520806;16611.66776664472;16805.41181058657;16899.23953422099;13684.247366394844;13865;13950.23273719955;14168.079074860205;14336.56990290293;3511.3328467591077;3522.5068490411363;3526.947095793565;3527.876524321662;3528.347255757693;111777.44111279472;117681;126833.73166268312;127681;131400;10020.248481363928;10641.680749577525;11317.094632429385;12367.505299788088;12974.610761677164;24137.51724965491;24420.26739197827;24509.264722058368;24640.383990400383;24847.503049939263;7489.550626962399;7532.7740167795055;7544.0192774938905;7548.169701332849;7558.735444259534;3773.132179598708;3804.6195380462286;3808.714346423974;3866.2460820139804;3873.341531939577;4228.873133805991;4281.385195079676;4306.913861722748;4313.762743049099;4320;829.5437509369823;853.176684499461;898.2948385517337;898.6475354591298;912.726182145367;644.616453210339;648.4455790299321;653.9084528166061;660.904168895517;672.2504407585604;9489.288303377274;10926.672199834018;11695.005924496343;11790.882091178979;11914.821277680841;644.5455953552735;644.716324817079;648.3710800523485;656.1994366872408;682.7269092363094;4926.685053274887;5094.5669618082875;5103.617228707862;5131.204663277198;5158.587313014949;100239.49880250698;100639.99360006306;102826.71732826807;103241;104754.4762276199;87954.52386547215;88210;88782;89889;91718.08281917228;50888.710008049726;59489.13320634145;70921;71583;76557.61721191359;10345.948270258601;11787.469563869476;12310.322932238812;12365.876341236473;12460.12779105454;37384.439233412064;37791.2441751158;37973.81013094917;38558.228835423695;39440.81677549678;61668;63363;64203.35796641974;65358.346416537126;66669;16666.916665416597;16718.49844504667;16792;16820.915895420443;17003.40488082911;15257.465988690343;17977.550561236072;18216.271349145885;18314.084295785426;18472.630547389246;13881.444742210198;16390.67218655644;16469.505914822574;16511.917440412722;16654.00075995444;16501.58746031359;16542.66914661724;16577.751333729764;16606.750898736285;16628.667426651642;16172.110533920748;16336.428225012067;16377.263023163749;16379.672406552041;16392.016479011298;11660.591879284184;11927.986121179796;12052.51789928393;12095.032397408362;12270.693232669255;11411.858814118521;11790.587329443772;12226.694332641755;12369.62891113268;12548.996080313736 21:28:49 INFO - PID 1643 | __end_tp_report 21:28:49 INFO - PID 1643 | __start_cc_report 21:28:49 INFO - PID 1643 | _x_x_mozilla_cycle_collect,1631 21:28:49 INFO - PID 1643 | __end_cc_report 21:28:49 INFO - PID 1643 | __startTimestamp1493008129431__endTimestamp 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | ------- Summary: start ------- 21:28:49 INFO - PID 1643 | Number of tests: 6 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6030.85 Median:6289.28 stddev:704.31 (11.2%) stddev-sans-first:671.74 21:28:49 INFO - PID 1643 | Values: 3246.2 3391.0 3436.7 3527.6 3565.6 5937.3 6125.7 6164.1 6164.2 6188.8 5445.9 5757.9 6015.1 6087.8 6119.7 5238.0 5270.9 5273.3 5316.1 5367.2 5356.4 5375.5 5377.1 5377.1 5389.7 5356.9 5361.6 5366.2 5372.4 5380.2 5373.2 5374.8 5378.1 5389.9 5403.2 5286.7 5326.5 5326.7 5340.8 5362.7 6201.8 6219.5 6220.8 6225.6 6266.7 6305.3 6529.4 6547.4 6587.8 6595.4 6443.5 6453.2 6455.3 6462.6 6466.2 5663.3 6177.1 6222.6 6229.8 6232.8 6747.7 6774.0 6782.6 6790.2 6794.2 6454.4 6456.6 6465.5 6468.7 6482.3 6345.3 6372.7 6511.7 6550.8 6626.9 6517.2 6536.2 6545.3 6549.0 6550.1 6486.4 6520.1 6542.7 6550.7 6557.8 5118.4 5207.4 5220.2 5238.8 5253.9 4675.3 4701.6 4703.5 4716.2 4729.6 6150.8 6162.4 6166.6 6169.5 6190.4 6287.6 6435.9 6617.6 6643.2 6650.8 6118.0 6151.4 6163.0 6181.3 6188.0 5754.4 5763.4 5764.8 5770.0 5780.8 6525.2 6773.2 6831.5 6845.1 6851.3 6337.1 6568.9 6639.7 6650.6 6652.2 5519.6 6329.3 6800.6 6803.6 6833.5 6441.4 6497.7 6505.6 6512.0 6512.4 5248.3 6330.0 6377.3 6441.5 6637.9 6366.1 6368.1 6373.7 6380.6 6387.7 6232.9 6267.1 6329.8 6389.9 6406.1 6255.6 6268.9 6289.3 6310.4 6314.4 6363.7 6389.6 6407.9 6413.1 6419.6 6306.5 6317.9 6320.5 6330.0 6339.7 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:42386.63 Median:30702.39 stddev:73180.62 (238.4%) stddev-sans-first:73319.13 21:28:49 INFO - PID 1643 | Values: 745.9 789.6 800.4 1106.2 1121.1 26485.3 26996.7 27005.0 27015.6 27034.8 26745.3 28165.9 37443.0 37980.9 38055.4 7297.0 8010.1 8331.6 8442.9 8492.5 8240.9 8365.5 8370.2 8373.5 8375.5 5913.9 6069.3 8249.6 8408.6 8427.0 8366.5 8434.6 8435.4 8448.2 8463.3 8201.7 8280.2 8282.4 8290.6 8290.9 25440.9 25599.6 35994.6 36464.5 36493.0 3558.6 3577.4 3586.1 3586.3 3587.7 30457.1 30502.7 30517.8 30544.8 30577.1 3096.5 3136.5 3154.1 3159.2 3167.2 295450.5 297689.0 298829.0 299153.0 300178.0 48710.5 48811.9 48831.5 48865.8 48960.5 50807.2 50831.0 50853.5 50894.2 50926.2 13875.0 13986.5 14032.0 14043.0 14049.2 11431.4 11437.7 11439.8 11453.8 11467.9 10427.2 12127.3 12319.1 12376.1 12453.3 4867.8 4879.8 4892.3 4892.9 4894.6 974.8 985.9 997.2 1010.6 1018.7 23871.5 24065.5 24102.9 24133.2 24165.0 1093.7 1104.7 1140.4 1144.9 1146.1 11131.8 12370.5 12370.9 12412.8 12421.4 229811.0 290863.0 292669.0 293082.0 293138.0 51455.7 51617.5 51620.7 51757.0 51799.0 1452.4 1485.1 1500.7 1502.3 1505.7 27594.0 27904.9 28488.7 28549.6 28674.6 35376.3 35465.6 35523.0 35542.0 35618.3 255884.0 256477.0 256626.0 257536.0 257559.4 30924.0 31090.4 31091.4 31105.5 31110.9 43971.8 44141.1 44154.0 44157.8 44182.3 25176.5 26432.7 26601.5 30502.6 30704.8 29656.0 29713.3 30278.8 30481.2 30587.7 36376.8 36743.3 36763.8 36801.4 36913.6 28812.3 29464.4 29722.6 30699.9 30979.7 20082.4 21938.5 22417.0 24052.5 24325.9 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:35512.98 Median:2172.56 stddev:93549.58 (4306.0%) stddev-sans-first:93774.94 21:28:49 INFO - PID 1643 | Values: 437.5 439.2 439.9 445.3 457.7 20780.8 21481.0 21522.5 21980.5 22220.7 21731.8 22240.9 22825.9 22872.9 23069.9 5256.0 5826.0 6231.9 6461.5 6463.9 6223.8 6385.7 6388.1 6391.4 6394.9 5550.3 5984.9 6293.1 6327.2 6350.0 6185.5 6293.6 6296.1 6316.2 6317.1 5400.5 5550.5 5612.9 5619.8 5621.7 23962.4 26988.0 27135.6 27191.6 27284.5 2038.4 2215.2 2217.1 2218.3 2221.3 17820.3 17838.7 18096.2 18110.0 18121.1 2128.3 2128.9 2167.8 2172.0 2173.1 154083.5 159748.0 159932.0 161891.4 163699.2 11140.6 12033.5 12103.2 12333.7 12483.8 13857.8 16516.7 16547.0 16570.0 16599.7 8529.5 8826.2 8851.4 8976.2 8993.2 7501.2 8070.0 8373.2 8415.2 8572.8 6578.8 7713.0 7789.3 7847.8 7864.4 1737.9 2120.8 2141.0 2148.2 2308.5 815.2 970.6 971.6 1006.2 1009.2 19937.1 20966.7 21215.5 21357.9 21706.2 893.8 982.1 1010.9 1017.7 1025.2 9641.3 9658.8 10544.8 10556.0 11064.7 527791.0 531472.0 561325.0 568973.0 571712.0 70440.6 123787.0 124176.0 135491.3 135584.0 1109.7 1191.6 1235.7 1260.6 1263.0 16463.6 20339.9 22235.1 22690.2 22820.5 54007.0 54276.7 54279.5 56756.7 57366.7 59537.7 74816.0 75680.2 76869.0 78043.0 10520.4 12605.1 12686.9 13010.2 13039.0 13778.5 13870.0 13917.5 14180.1 14210.0 11780.1 11782.0 11949.9 12036.1 12150.5 11098.4 11121.9 11170.9 11562.1 11575.4 11616.7 11797.3 12091.3 12091.9 12210.6 12483.8 12518.4 12819.1 12840.8 12868.5 11823.2 11923.3 11941.5 12046.0 12056.4 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7110.78 Median:3989.16 stddev:4512.26 (113.1%) stddev-sans-first:4503.00 21:28:49 INFO - PID 1643 | Values: 1193.7 1408.3 1443.8 1465.0 1466.5 9711.3 10206.0 10217.9 10229.7 10236.4 9850.8 11260.4 11574.5 11581.4 11583.2 2494.2 2539.7 2540.9 2541.3 2543.1 2114.2 2374.3 2513.3 2514.4 2516.3 2151.9 2183.0 2460.5 2535.5 2536.7 2462.7 2477.5 2488.8 2495.3 2502.9 2429.5 2474.8 2478.2 2482.5 2492.2 11683.9 11788.8 11802.7 11803.8 11816.6 6395.3 6640.0 6642.9 6655.9 6672.2 3816.2 3998.8 4160.5 4163.9 4166.6 1063.0 1213.5 1221.3 1253.8 1261.1 16705.7 16761.9 16772.5 16777.7 16808.9 5764.8 5915.6 5954.9 6060.7 6101.5 13797.2 13808.2 13816.8 13842.4 13852.6 6618.4 6740.3 6741.2 6753.4 6764.4 6087.6 6135.2 6210.6 6219.7 6231.2 4438.7 4586.5 4593.0 4631.2 4637.8 1421.9 1435.9 1441.7 1459.9 1469.8 648.2 652.5 741.4 764.1 770.8 6170.8 6278.9 6455.1 6546.3 6612.5 829.8 858.8 929.2 940.1 942.6 3701.0 3979.5 4014.6 4015.2 4147.0 14442.9 15165.8 15174.9 15177.5 15193.5 12315.4 14482.9 15055.0 15060.8 15118.3 8290.3 8499.1 8532.1 8535.0 8543.4 6471.0 6821.5 7016.2 7030.8 7082.5 12874.0 12912.3 12940.5 13158.3 13162.6 10835.6 13185.1 13375.2 13595.3 13799.7 9244.0 9474.2 9588.2 9740.5 9748.8 11079.0 11200.6 11217.4 11223.8 11225.0 9077.3 9291.9 9301.0 9392.7 9399.3 9059.0 9217.0 9224.8 9238.0 9357.3 8116.7 8303.3 8309.4 8319.4 8322.4 4970.6 5290.7 5357.5 5935.6 6202.3 5782.2 6025.2 6071.3 6072.7 6363.2 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5108.96 Median:5695.17 stddev:1548.40 (27.2%) stddev-sans-first:1511.80 21:28:49 INFO - PID 1643 | Values: 396.1 405.4 407.0 410.4 414.5 5269.9 5950.3 5993.8 5994.4 6006.5 4832.9 5264.9 5354.3 5764.6 5852.9 4409.7 4432.6 4449.8 4455.5 4469.2 4432.9 4467.5 4472.6 4477.7 4484.5 4332.9 4366.9 4395.0 4415.8 4453.7 3388.8 4407.3 4409.4 4417.4 4426.9 3245.5 3606.0 3944.2 3966.9 3967.7 5491.4 5672.8 5761.5 5790.0 5795.1 5309.7 5314.0 5343.4 5358.9 5374.2 6306.6 6313.7 6321.3 6327.7 6345.2 4323.6 4440.2 4525.7 4535.8 4546.7 5658.3 6025.4 6456.6 6474.9 6536.9 4270.6 4449.8 4456.3 4461.5 4462.6 4042.9 4280.9 4488.2 4695.5 4717.8 5344.0 5344.7 5344.7 5378.2 5380.8 5282.8 5717.5 6071.4 6338.1 6352.8 1346.4 1369.6 1606.5 1609.8 1611.7 928.9 1091.0 1117.5 1120.7 1121.2 5625.3 5801.6 5826.0 5855.2 5868.7 5439.4 6511.2 6517.2 6533.4 6549.1 5567.6 5851.4 5884.6 5910.7 5954.4 3340.9 3389.8 3389.9 3400.0 3403.5 5621.7 6402.3 6611.6 6700.6 6711.6 6638.4 6644.3 6653.2 6656.0 6658.4 5543.2 6548.5 6657.9 6726.6 6733.7 5945.5 6037.5 6435.8 6449.8 6471.2 5757.4 6383.7 6398.6 6413.3 6451.8 5558.8 6332.5 6649.5 6693.9 6695.0 3583.6 4247.7 4264.2 4277.8 4288.1 5091.5 6222.3 6421.9 6467.5 6490.0 5441.6 6225.5 6252.5 6269.7 6275.5 5780.9 5911.4 6240.9 6273.3 6314.2 4602.5 5779.2 5839.6 6019.7 6132.0 6158.8 6230.4 6235.2 6252.6 6269.9 5931.3 5932.2 6065.3 6121.9 6131.2 21:28:49 INFO - PID 1643 | 21:28:49 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:21159.84 Median:18096.91 stddev:29744.73 (164.4%) stddev-sans-first:29788.47 21:28:49 INFO - PID 1643 | Values: 693.8 791.5 838.6 842.5 850.8 12800.7 17907.0 18244.8 18274.5 18292.3 16497.7 16655.2 16657.3 16667.6 16703.8 959.5 994.8 1001.8 1009.4 1017.8 972.9 982.7 993.4 995.1 1009.0 870.7 1042.4 1042.4 1045.9 1051.9 1031.8 1034.5 1035.5 1039.2 1040.9 780.0 783.5 783.6 784.0 786.2 13638.0 16045.4 16281.0 16443.5 16626.6 16425.3 16496.4 16611.7 16805.4 16899.2 13684.2 13865.0 13950.2 14168.1 14336.6 3511.3 3522.5 3526.9 3527.9 3528.3 111777.4 117681.0 126833.7 127681.0 131400.0 10020.2 10641.7 11317.1 12367.5 12974.6 24137.5 24420.3 24509.3 24640.4 24847.5 7489.6 7532.8 7544.0 7548.2 7558.7 3773.1 3804.6 3808.7 3866.2 3873.3 4228.9 4281.4 4306.9 4313.8 4320.0 829.5 853.2 898.3 898.6 912.7 644.6 648.4 653.9 660.9 672.3 9489.3 10926.7 11695.0 11790.9 11914.8 644.5 644.7 648.4 656.2 682.7 4926.7 5094.6 5103.6 5131.2 5158.6 100239.5 100640.0 102826.7 103241.0 104754.5 87954.5 88210.0 88782.0 89889.0 91718.1 50888.7 59489.1 70921.0 71583.0 76557.6 10345.9 11787.5 12310.3 12365.9 12460.1 37384.4 37791.2 37973.8 38558.2 39440.8 61668.0 63363.0 64203.4 65358.3 66669.0 16666.9 16718.5 16792.0 16820.9 17003.4 15257.5 17977.6 18216.3 18314.1 18472.6 13881.4 16390.7 16469.5 16511.9 16654.0 16501.6 16542.7 16577.8 16606.8 16628.7 16172.1 16336.4 16377.3 16379.7 16392.0 11660.6 11928.0 12052.5 12095.0 12270.7 11411.9 11790.6 12226.7 12369.6 12549.0 21:28:49 INFO - PID 1643 | -------- Summary: end -------- 21:28:49 INFO - PID 1643 | 21:28:50 INFO - TEST-INFO | 1643: exit 0 21:28:50 INFO - TEST-OK | dromaeo_css | took 1118724ms 21:28:50 INFO - TEST-START | kraken 21:28:50 INFO - operating with platform_type : mac_ 21:28:50 INFO - Initialising browser for kraken test... 21:28:50 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmplRyomF/profile http://localhost:49235/getInfo.html) 21:28:52 INFO - PID 1649 | __metrics Screen width/height:1600/1200 21:28:52 INFO - PID 1649 | colorDepth:24 21:28:52 INFO - PID 1649 | Browser inner width/height: 1024/689 21:28:52 INFO - PID 1649 | __metrics 21:28:52 INFO - PID 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:28:52 INFO - PID 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:28:53 INFO - TEST-INFO | 1649: exit 0 21:28:53 INFO - Browser initialized. 21:28:53 INFO - Running cycle 1/1 for kraken test... 21:28:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmplRyomF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:29:06 INFO - PID 1650 | RSS: Main: 241864704 21:29:06 INFO - PID 1650 | 21:29:08 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 21:29:09 INFO - PID 1650 | RSS: Main: 311541760 21:29:09 INFO - PID 1650 | 21:29:12 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 21:29:12 INFO - PID 1650 | RSS: Main: 295493632 21:29:12 INFO - PID 1650 | 21:29:16 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 21:29:16 INFO - PID 1650 | RSS: Main: 386002944 21:29:16 INFO - PID 1650 | 21:29:18 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 21:29:19 INFO - PID 1650 | RSS: Main: 289181696 21:29:19 INFO - PID 1650 | 21:29:21 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:29:22 INFO - PID 1650 | RSS: Main: 291229696 21:29:22 INFO - PID 1650 | 21:29:25 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 21:29:25 INFO - PID 1650 | RSS: Main: 354091008 21:29:25 INFO - PID 1650 | 21:29:28 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 21:29:29 INFO - PID 1650 | RSS: Main: 371318784 21:29:29 INFO - PID 1650 | 21:29:31 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 21:29:32 INFO - PID 1650 | RSS: Main: 381353984 21:29:32 INFO - PID 1650 | 21:29:34 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:34 INFO - PID 1650 | RSS: Main: 333312000 21:29:34 INFO - PID 1650 | 21:29:36 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:37 INFO - PID 1650 | RSS: Main: 334499840 21:29:37 INFO - PID 1650 | 21:29:39 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:39 INFO - PID 1650 | RSS: Main: 336969728 21:29:39 INFO - PID 1650 | 21:29:42 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:43 INFO - PID 1650 | RSS: Main: 350412800 21:29:43 INFO - PID 1650 | 21:29:46 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:47 INFO - PID 1650 | RSS: Main: 342507520 21:29:47 INFO - PID 1650 | 21:29:48 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 21:29:49 INFO - PID 1650 | RSS: Main: 385286144 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | __start_tp_report 21:29:49 INFO - PID 1650 | _x_x_mozilla_page_load 21:29:49 INFO - PID 1650 | _x_x_mozilla_page_load_details 21:29:49 INFO - PID 1650 | |i|pagename|runs| 21:29:49 INFO - PID 1650 | |0;ai-astar;110;111;112;111;109;112;111;109;110;111 21:29:49 INFO - PID 1650 | |1;audio-beat-detection;145;93;136;188;139;109;109;108;137;111 21:29:49 INFO - PID 1650 | |2;audio-dft;185;185;185;186;186;187;184;186;180;183 21:29:49 INFO - PID 1650 | |3;audio-fft;79;62;88;117;89;78;58;58;83;56 21:29:49 INFO - PID 1650 | |4;audio-oscillator;91;71;87;69;67;68;108;100;101;90 21:29:49 INFO - PID 1650 | |5;imaging-gaussian-blur;88;87;87;87;90;113;88;87;89;87 21:29:49 INFO - PID 1650 | |6;imaging-darkroom;94;95;94;94;94;93;94;94;94;94 21:29:49 INFO - PID 1650 | |7;imaging-desaturate;84;81;85;81;83;84;84;86;85;83 21:29:49 INFO - PID 1650 | |8;json-parse-financial;51;49;50;49;49;49;47;47;49;48 21:29:49 INFO - PID 1650 | |9;json-stringify-tinderbox;52;59;55;66;61;59;57;56;55;56 21:29:49 INFO - PID 1650 | |10;stanford-crypto-aes;84;81;83;85;82;83;83;82;81;82 21:29:49 INFO - PID 1650 | |11;stanford-crypto-ccm;133;136;139;133;134;146;136;135;177;143 21:29:49 INFO - PID 1650 | |12;stanford-crypto-pbkdf2;186;186;184;191;184;186;181;184;188;182 21:29:49 INFO - PID 1650 | |13;stanford-crypto-sha256-iterative;69;68;66;67;67;68;71;68;68;67 21:29:49 INFO - PID 1650 | __end_tp_report 21:29:49 INFO - PID 1650 | __start_cc_report 21:29:49 INFO - PID 1650 | _x_x_mozilla_cycle_collect,2178 21:29:49 INFO - PID 1650 | __end_cc_report 21:29:49 INFO - PID 1650 | __startTimestamp1493008189092__endTimestamp 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | ------- Summary: start ------- 21:29:49 INFO - PID 1650 | Number of tests: 14 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.07 (1.0%) stddev-sans-first:1.12 21:29:49 INFO - PID 1650 | Values: 110.0 111.0 112.0 111.0 109.0 112.0 111.0 109.0 110.0 111.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:138.00 stddev:27.46 (19.9%) stddev-sans-first:28.39 21:29:49 INFO - PID 1650 | Values: 145.0 93.0 136.0 188.0 139.0 109.0 109.0 108.0 137.0 111.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:2.00 (1.1%) stddev-sans-first:2.12 21:29:49 INFO - PID 1650 | Values: 185.0 185.0 185.0 186.0 186.0 187.0 184.0 186.0 180.0 183.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#3] audio-fft Cycles:10 Average:76.80 Median:78.50 stddev:19.13 (24.4%) stddev-sans-first:20.27 21:29:49 INFO - PID 1650 | Values: 79.0 62.0 88.0 117.0 89.0 78.0 58.0 58.0 83.0 56.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:70.00 stddev:15.42 (22.0%) stddev-sans-first:16.21 21:29:49 INFO - PID 1650 | Values: 91.0 71.0 87.0 69.0 67.0 68.0 108.0 100.0 101.0 90.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:87.50 stddev:8.04 (9.2%) stddev-sans-first:8.49 21:29:49 INFO - PID 1650 | Values: 88.0 87.0 87.0 87.0 90.0 113.0 88.0 87.0 89.0 87.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:29:49 INFO - PID 1650 | Values: 94.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.65 (2.0%) stddev-sans-first:1.74 21:29:49 INFO - PID 1650 | Values: 84.0 81.0 85.0 81.0 83.0 84.0 84.0 86.0 85.0 83.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#8] json-parse-financial Cycles:10 Average:48.80 Median:49.00 stddev:1.23 (2.5%) stddev-sans-first:1.01 21:29:49 INFO - PID 1650 | Values: 51.0 49.0 50.0 49.0 49.0 49.0 47.0 47.0 49.0 48.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:3.89 (6.7%) stddev-sans-first:3.56 21:29:49 INFO - PID 1650 | Values: 52.0 59.0 55.0 66.0 61.0 59.0 57.0 56.0 55.0 56.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.26 (1.5%) stddev-sans-first:1.24 21:29:49 INFO - PID 1650 | Values: 84.0 81.0 83.0 85.0 82.0 83.0 83.0 82.0 81.0 82.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:137.50 stddev:13.30 (9.7%) stddev-sans-first:13.77 21:29:49 INFO - PID 1650 | Values: 133.0 136.0 139.0 133.0 134.0 146.0 136.0 135.0 177.0 143.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:186.00 stddev:2.90 (1.6%) stddev-sans-first:3.06 21:29:49 INFO - PID 1650 | Values: 186.0 186.0 184.0 191.0 184.0 186.0 181.0 184.0 188.0 182.0 21:29:49 INFO - PID 1650 | 21:29:49 INFO - PID 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.39 21:29:49 INFO - PID 1650 | Values: 69.0 68.0 66.0 67.0 67.0 68.0 71.0 68.0 68.0 67.0 21:29:49 INFO - PID 1650 | -------- Summary: end -------- 21:29:49 INFO - PID 1650 | 21:29:50 INFO - TEST-INFO | 1650: exit 0 21:29:50 INFO - TEST-OK | kraken | took 60158ms 21:29:50 INFO - SUITE-END | took 1178s 21:29:50 INFO - Completed test suite (00:19:39) 21:29:50 INFO - javascript benchmark 21:29:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7746.408970628367, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.204679853436, 3391.0, 3436.7250619950405, 3527.629598892117, 3565.554305711786, 5937.317208521022, 6125.693715314228, 6164.137020817084, 6164.167837341957, 6188.845278868031, 5445.918311225335, 5757.856053598652, 6015.0676645120075, 6087.756489740405, 6119.7246123924415, 5238.00477909198, 5270.894582108374, 5273.261743355914, 5316.149416093426, 5367.221752845835, 5356.3572371315495, 5375.489328513804, 5377.059014672436, 5377.139657654776, 5389.676619402829, 5356.946430535703, 5361.624686271963, 5366.168243922199, 5372.382176049765, 5380.192971054354, 5373.167159090347, 5374.785008599671, 5378.058839703036, 5389.946100539023, 5403.189521571757, 5286.709230992294, 5326.467353264643, 5326.653767505139, 5340.786368545254, 5362.6782393056155, 6201.844953876144, 6219.471344935686, 6220.813375598739, 6225.564210505267, 6266.717997690115, 6305.274893387274, 6529.4123528882155, 6547.377999090127, 6587.80236592903, 6595.373439523238, 6443.452306553949, 6453.16108905844, 6455.257645370749, 6462.612243265419, 6466.191726034246, 5663.263775709132, 6177.073438984188, 6222.62664240138, 6229.7508099676415, 6232.844178895564, 6747.662616869137, 6773.966130169416, 6782.626955517494, 6790.1851777786, 6794.218664853605, 6454.386833250834, 6456.580322279036, 6465.515086368541, 6468.708908099147, 6482.286948435668, 6345.270293916259, 6372.745090196433, 6511.739530418825, 6550.803475895731, 6626.9337306627285, 6517.152770139852, 6536.182977127859, 6545.345465453416, 6548.967255163789, 6550.115734375893, 6486.383793539606, 6520.0871877937125, 6542.738290468328, 6550.737970481127, 6557.803265902031, 5118.38579370478, 5207.37511498615, 5220.190870415092, 5238.7904483820985, 5253.947460525423, 4675.345451636774, 4701.623870090384, 4703.482616912137, 4716.245400735866, 4729.574338309569, 6150.815475535741, 6162.445379915829, 6166.599171053867, 6169.537284703665, 6190.442860142609, 6287.559870809091, 6435.935640643534, 6617.602943823386, 6643.2028156620545, 6650.767223147167, 6118.010103775246, 6151.384861513902, 6163.0, 6181.320054793969, 6188.0, 5754.395788442237, 5763.423657634287, 5764.827055188351, 5770.0, 5780.826575202751, 6525.2169739631545, 6773.221079575912, 6831.4534837212905, 6845.110135682329, 6851.3491218334175, 6337.081123237012, 6568.9014664781025, 6639.6680165992475, 6650.567713098633, 6652.2349929756765, 5519.613627046228, 6329.335419780857, 6800.625965571743, 6803.625800581016, 6833.521653484208, 6441.355864413708, 6497.74009039652, 6505.577137486048, 6511.967440162769, 6512.446442052478, 5248.317718696545, 6329.968350158219, 6377.330380310186, 6441.516886233458, 6637.933620663732, 6366.108744775827, 6368.108464814837, 6373.7131829066875, 6380.617162970237, 6387.744490220339, 6232.875342493216, 6267.122602835698, 6329.841753956188, 6389.93610063912, 6406.135171751754, 6255.56211065221, 6268.937310626835, 6289.276733175743, 6310.400511951358, 6314.368563143649, 6363.713632886439, 6389.648569328546, 6407.871842563216, 6413.102165696713, 6419.614823110628, 6306.4639505642535, 6317.9052314214405, 6320.462760665211, 6330.0, 6339.683015849281], "value": 5983.7726126746165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.8843879198727, 789.5539020453443, 800.4036992440632, 1106.170372220835, 1121.0639116337868, 26485.337866553346, 26996.730032699666, 27005.0, 27015.594766078477, 27034.783434745434, 26745.331366715844, 28165.85917070412, 37443.0, 37980.923052311635, 38055.42916856249, 7297.0, 8010.118886922434, 8331.62507687154, 8442.915570844274, 8492.490450572954, 8240.876386854203, 8365.498070115782, 8370.204830541119, 8373.455725377862, 8375.455595386311, 5913.852153696149, 6069.30203026651, 8249.628766705482, 8408.621612027442, 8426.957865210665, 8366.53984030878, 8434.57827108642, 8435.427194705613, 8448.155184481564, 8463.322934165282, 8201.71294004713, 8280.213379728915, 8282.42023058386, 8290.626921788535, 8290.917090829134, 25440.872795635903, 25599.61600575993, 35994.64005359939, 36464.453033204525, 36493.0, 3558.6085530591613, 3577.4454959481322, 3586.1393265616325, 3586.282743451294, 3587.6950459211, 30457.086287411414, 30502.694973050206, 30517.847410762803, 30544.847275763477, 30577.08268751941, 3096.4890793019126, 3136.4824803907327, 3154.0853152585723, 3159.210197450637, 3167.224030112637, 295450.52274738706, 297689.0, 298829.0, 299153.00846991467, 300178.0, 48710.51289487131, 48811.85099266531, 48831.51168488341, 48865.7783555414, 48960.51039489631, 50807.23789143166, 50831.0, 50853.491465085615, 50894.23658645123, 50926.23610645843, 13875.0, 13986.510472133426, 14032.017758756789, 14043.0, 14049.227292498806, 11431.371274579978, 11437.714057148638, 11439.828402573969, 11453.828192577119, 11467.942660286812, 10427.217958653131, 12127.33299668509, 12319.137660363689, 12376.143578463303, 12453.25280483174, 4867.805287788448, 4879.804807807648, 4892.2661600760175, 4892.8532144035735, 4894.608431325485, 974.7904200596905, 985.8964808695127, 997.2072202598952, 1010.6406882742699, 1018.7096677446892, 23871.522569548513, 24065.51868962611, 24102.87948560246, 24133.155339563033, 24165.033398664207, 1093.748437859281, 1104.745908441063, 1140.4297851074464, 1144.891235332642, 1146.140394703972, 11131.833022504668, 12370.505179792888, 12370.938145309216, 12412.751744965231, 12421.44103515344, 229811.0, 290863.0, 292669.0, 293082.0, 293138.0, 51455.71360715937, 51617.48382516127, 51620.74189629028, 51757.0, 51799.0, 1452.3899962015978, 1485.0569888120906, 1500.7373709600777, 1502.2713983717888, 1505.6913332766976, 27594.0, 27904.860475697493, 28488.715112849437, 28549.571756423255, 28674.56988145221, 35376.29247414986, 35465.64534354623, 35522.99999999897, 35542.0, 35618.28763424769, 255884.0, 256477.0, 256626.0, 257536.0, 257559.42440576103, 30924.0, 31090.378192436478, 31091.37817243688, 31105.533416999217, 31110.91111811076, 43971.78014109909, 44141.11717765562, 44154.0, 44157.77921110374, 44182.33726494169, 25176.496470070862, 26432.735672643026, 26601.467970640093, 30502.62738176743, 30704.846475768372, 29656.0, 29713.25716857096, 30278.84860575683, 30481.237969050064, 30587.694123058485, 36376.81811590925, 36743.26513469662, 36763.816180918926, 36801.447978279815, 36913.630863692095, 28812.279693007004, 29464.410711785215, 29722.554161688025, 30699.9255026073, 30979.69020309768, 20082.39390663633, 21938.451538711022, 22417.0, 24052.51894962126, 24325.878370608032], "value": 16745.446537089654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.5252850657037, 439.18969501270146, 439.92081425343434, 445.2764258080619, 457.69563240445126, 20780.792192078094, 21481.03335349909, 21522.461938451528, 21980.450488737788, 22220.666689999664, 21731.782682173172, 22240.888795556, 22825.85870706462, 22872.885635571798, 23069.884650576725, 5256.0, 5825.970870145643, 6231.8753624927585, 6461.547691661585, 6463.903041454382, 6223.813285601439, 6385.712642931079, 6388.073729309247, 6391.424771770539, 6394.872102557946, 5550.306211723535, 5984.88030239395, 6293.087502312162, 6327.177466929293, 6350.047492876082, 6185.474234690057, 6293.590916590453, 6296.055591661242, 6316.210473690789, 6317.1156038154695, 5400.459954004607, 5550.500454959033, 5612.887742245173, 5619.831405057814, 5621.662700237999, 23962.40093997664, 26988.0, 27135.592966105523, 27191.592126118125, 27284.454310913672, 2038.3681058871798, 2215.2246713650256, 2217.135317226283, 2218.3123231798195, 2221.2891874600136, 17820.287188512444, 17838.732419013726, 18096.18567164481, 18110.0, 18121.09394530268, 2128.3402145334994, 2128.8509804313703, 2167.837412194076, 2171.9891400543056, 2173.1307477009163, 154083.52540610262, 159748.0, 159932.0, 161891.38108619, 163699.1815040917, 11140.554377824958, 12033.518659253707, 12103.152779305365, 12333.691657708629, 12483.812742808865, 13857.792133118011, 16516.669666606602, 16547.007179569264, 16570.0, 16599.6680066398, 8529.488230706178, 8826.249768769727, 8851.380403371832, 8976.192142707188, 8993.190612844875, 7501.249875012564, 8069.9596502018285, 8373.246407823324, 8415.158484151658, 8572.785680358042, 6578.76974305897, 7712.994621398477, 7789.260020298063, 7847.803804904923, 7864.449488535862, 1737.904415257173, 2120.787921207867, 2140.989295053546, 2148.2481131604127, 2308.5036717105904, 815.2214635023538, 970.5632465390603, 971.5725080964353, 1006.1699098243978, 1009.1573536097294, 19937.102830372667, 20966.685499717212, 21215.469613259484, 21357.893210533846, 21706.240281590068, 893.7710647859194, 982.1455333859587, 1010.8938561451089, 1017.6845177994697, 1025.1849779425374, 9641.325107242566, 9658.75853103664, 10544.841827372595, 10556.049955504042, 11064.668059958214, 527791.0, 531472.0, 561325.0, 568973.0, 571712.0, 70440.64779676069, 123787.0, 124176.0, 135491.3225433886, 135584.0, 1109.672646569264, 1191.5889018288676, 1235.7034311765112, 1260.602910083321, 1262.9936850315873, 16463.60059394965, 20339.8983005084, 22235.110595576643, 22690.20584279542, 22820.543589128458, 54007.0, 54276.72861635667, 54279.45720542902, 56756.71621641865, 57366.7131664339, 59537.70231148817, 74816.0, 75680.24319756732, 76869.0, 78043.04892377736, 10520.368777873353, 12605.054620903285, 12686.936565317483, 13010.21938683682, 13039.0, 13778.517751878637, 13870.029097963046, 13917.51288704931, 14180.14919104857, 14210.00529962934, 11780.057595392176, 11782.0, 11949.940250299042, 12036.097292702907, 12150.513979441077, 11098.389588572383, 11121.944390277997, 11170.944145279222, 11562.132840036862, 11575.363355015555, 11616.709582260512, 11797.29216247028, 12091.334976576021, 12091.939540302243, 12210.572629958264, 12483.75032499363, 12518.374081295717, 12819.102662813513, 12840.807387889003, 12868.549600763929, 11823.172377933462, 11923.284602923852, 11941.46263418131, 12046.0, 12056.397180141134], "value": 10598.577189895697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.659806955018, 1408.2747385096675, 1443.841177470478, 1464.952558920372, 1466.457410758019, 9711.271654625905, 10206.030427109412, 10217.897821021788, 10229.744256393584, 10236.43699596522, 9850.753731156725, 11260.43697815108, 11574.53701851927, 11581.36302503362, 11583.18917675763, 2494.1769216158714, 2539.7079335876333, 2540.9110681126162, 2541.275736415122, 2543.0844895837486, 2114.164904862578, 2374.25211058516, 2513.258588716324, 2514.4342522932284, 2516.2954372775653, 2151.9354419367446, 2183.0, 2460.458699086207, 2535.518251532203, 2536.73364296748, 2462.6675398821108, 2477.4797292568583, 2488.7760101590943, 2495.3262619092743, 2502.9374265643323, 2429.514097180571, 2474.7648973347505, 2478.2069737683946, 2482.453860150764, 2492.1526680928573, 11683.941580292128, 11788.764224715458, 11802.704932376759, 11803.822942655866, 11816.586419475278, 6395.328490508523, 6639.966800166017, 6642.900356494656, 6655.900161497581, 6672.232693240242, 3816.1985982943615, 3998.8400463981407, 4160.479940007499, 4163.875083747493, 4166.64583510402, 1062.9627963021335, 1213.4842691855927, 1221.309959872678, 1253.7743206222876, 1261.0794120292146, 16705.749413758804, 16761.91619041909, 16772.496825095266, 16777.66444671112, 16808.915955420267, 5764.827055188351, 5915.585908986416, 5954.880902382015, 6060.666663333559, 6101.481374083164, 13797.172169669851, 13808.240546770025, 13816.825569826477, 13842.377093030838, 13852.614738526067, 6618.404343609098, 6740.325967403221, 6741.157355330583, 6753.425958793558, 6764.3573860483175, 6087.57386982907, 6135.171751813537, 6210.565260431817, 6219.689015549295, 6231.189945307172, 4438.690586277056, 4586.541345865387, 4593.012502312019, 4631.212693842055, 4637.837675681335, 1421.8791402730883, 1435.8635929586674, 1441.654003039263, 1459.9270036498133, 1469.8383177850642, 648.1618920389868, 652.5301782716436, 741.3920585120258, 764.0983639305562, 770.7803276066406, 6170.81487555374, 6278.937210627835, 6455.128557644752, 6546.312637173123, 6612.471002319803, 829.8215883585058, 858.8325276571134, 929.2240978782658, 940.0505489455562, 942.5946842857637, 3701.0, 3979.4826672532963, 4014.6186112319865, 4015.1768887378016, 4147.04617937876, 14442.927785361217, 15165.848341516665, 15174.93775435731, 15177.468788592567, 15193.544193673986, 12315.4458049388, 14482.855171448151, 15055.0, 15060.849391506164, 15118.319675614624, 8290.295324897452, 8499.065102838682, 8532.104129066483, 8535.0, 8543.444676096035, 6471.0, 6821.488388370793, 7016.19313778922, 7030.824229394101, 7082.504224704221, 12874.0, 12912.289824059766, 12940.547080852126, 13158.342082896008, 13162.60512184636, 10835.64554430696, 13185.07704460717, 13375.197488150741, 13595.252261125337, 13799.655008624462, 9243.953780231324, 9474.24206063527, 9588.232941364813, 9740.464274464972, 9748.805023899624, 11079.0, 11200.551977921117, 11217.439128043728, 11223.775524489301, 11224.989750922456, 9077.319201059814, 9291.907080929104, 9300.953495232481, 9392.718218453458, 9399.295052870926, 9059.048799875918, 9216.95391523065, 9224.769380765267, 9238.030006849183, 9357.251419886257, 8116.675332986614, 8303.252707256375, 8309.418340716333, 8319.41764076533, 8322.37582181351, 4970.558538023933, 5290.709011004432, 5357.544608708147, 5935.584509084322, 6202.255729312511, 5782.161586570008, 6025.18659980897, 6071.301800292847, 6072.696365181811, 6363.172787537591], "value": 5362.465012309696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.1166598485378, 405.3736976371506, 407.04750882933945, 410.3946678648995, 414.46120043942886, 5269.86825329367, 5950.256217972754, 5993.831202915433, 5994.370591087933, 6006.4894483968865, 4832.8884356598, 5264.868378290545, 5354.303940487741, 5764.596478246524, 5852.912206316909, 4409.706952384758, 4432.578905004019, 4449.777511124447, 4455.509893911667, 4469.195544801934, 4432.911341773162, 4467.463904331468, 4472.575105364985, 4477.686561940665, 4484.529124441936, 4332.851685437746, 4366.890827729317, 4395.011122497429, 4415.779211039435, 4453.688241823057, 3388.8136152511725, 4407.338899165119, 4409.426774519292, 4417.3815665806815, 4426.889327766816, 3245.464498357768, 3605.9542732607774, 3944.1520073184115, 3966.8809935701975, 3967.662748666367, 5491.36849262332, 5672.8014519492035, 5761.510271626917, 5790.0, 5795.146227758535, 5309.734513274359, 5313.997591360908, 5343.3587969443915, 5358.91961620576, 5374.220737992969, 6306.558540902139, 6313.747450102036, 6321.273053598849, 6327.715252813588, 6345.238571371465, 4323.589259020388, 4440.200763862504, 4525.683202175849, 4535.7732113394195, 4546.704464209815, 5658.292713410824, 6025.367336429656, 6456.644884531396, 6474.935250647527, 6536.93463065368, 4270.572942705705, 4449.83818770225, 4456.286994080931, 4461.460796025366, 4462.642988560908, 4042.8787136385954, 4280.850170244026, 4488.192125417391, 4695.530446955346, 4717.787699553528, 5343.973280133574, 5344.679319240858, 5344.732763361816, 5378.220158077057, 5380.757865896044, 5282.7622756976025, 5717.542596592262, 6071.423214794588, 6338.112664227012, 6352.777652782131, 1346.4412268908488, 1369.6301998460558, 1606.5341051095052, 1609.8390160983809, 1611.7106314947994, 928.8885333759993, 1091.0230544727897, 1117.463617463622, 1120.6918097523082, 1121.2095472691733, 5625.324961004624, 5801.564882633735, 5826.0, 5855.180274761537, 5868.706564671749, 5439.374471935699, 6511.186101737283, 6517.152770139852, 6533.41199292066, 6549.115869357671, 5567.610267281251, 5851.414858514115, 5884.58807883444, 5910.674912879746, 5954.374790647006, 3340.88306909257, 3389.81356025416, 3389.9152521187166, 3400.013995941199, 3403.50649155871, 5621.7189140542805, 6402.327755585689, 6611.628069684495, 6700.564463309869, 6711.563748356341, 6638.435732962752, 6644.302348253461, 6653.234877988996, 6655.966720166368, 6658.400743933069, 5543.1685247213245, 6548.476121910331, 6657.933420665731, 6726.630035348103, 6733.696983635748, 5945.483901605063, 6037.486813620892, 6435.839104022437, 6449.774257900951, 6471.188067341152, 5757.36668966405, 6383.691343274711, 6398.584092034003, 6413.262474815456, 6451.806445806634, 5558.805441809679, 6332.493400528039, 6649.501287403367, 6693.933060669526, 6695.0, 3583.552055993001, 4247.683218202367, 4264.189803937242, 4277.8288868444915, 4288.14237152577, 5091.490850914879, 6222.253329600477, 6421.853291887035, 6467.482601391972, 6490.0, 5441.646292990943, 6225.470834979077, 6252.531060170414, 6269.749210031548, 6275.466585340298, 5780.855478613068, 5911.408859114054, 6240.937590624036, 6273.278572964167, 6314.210723659543, 4602.539746025371, 5779.219805326227, 5839.649621022582, 6019.70576326092, 6131.957567213495, 6158.846028849135, 6230.376962303733, 6235.189425374672, 6252.562320637512, 6269.905951410641, 5931.347551769388, 5932.16949627044, 6065.332813390612, 6121.8980583495395, 6131.172291740558], "value": 4637.888286453663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.7571849852549, 791.4736700094437, 838.5681374092344, 842.5281842168382, 850.8255807559449, 12800.743985120303, 17907.0, 18244.81755182448, 18274.54313642158, 18292.268309267612, 16497.67004659906, 16655.16724163793, 16657.33370665175, 16667.583310417216, 16703.83296167038, 959.5490119643756, 994.8109859126779, 1001.849722541621, 1009.3590569988073, 1017.7964407118569, 972.868662730533, 982.6658935961772, 993.3642468819961, 995.1093771074884, 1009.0111690543272, 870.7387783664907, 1042.3797840285056, 1042.3849928542159, 1045.8954104589518, 1051.8842927277992, 1031.7678522332415, 1034.5396298647106, 1035.5495359518634, 1039.1634734039096, 1040.9323393979366, 779.99770295171, 783.475071701961, 783.5925318834231, 784.0317208247809, 786.1509569664748, 13638.0, 16045.438409655722, 16281.0, 16443.506694799176, 16626.58433539171, 16425.26086326118, 16496.42262520806, 16611.66776664472, 16805.41181058657, 16899.23953422099, 13684.247366394844, 13865.0, 13950.23273719955, 14168.079074860205, 14336.56990290293, 3511.3328467591077, 3522.5068490411363, 3526.947095793565, 3527.876524321662, 3528.347255757693, 111777.44111279472, 117681.0, 126833.73166268312, 127681.0, 131400.0, 10020.248481363928, 10641.680749577525, 11317.094632429385, 12367.505299788088, 12974.610761677164, 24137.51724965491, 24420.26739197827, 24509.264722058368, 24640.383990400383, 24847.503049939263, 7489.550626962399, 7532.7740167795055, 7544.0192774938905, 7548.169701332849, 7558.735444259534, 3773.132179598708, 3804.6195380462286, 3808.714346423974, 3866.2460820139804, 3873.341531939577, 4228.873133805991, 4281.385195079676, 4306.913861722748, 4313.762743049099, 4320.0, 829.5437509369823, 853.176684499461, 898.2948385517337, 898.6475354591298, 912.726182145367, 644.616453210339, 648.4455790299321, 653.9084528166061, 660.904168895517, 672.2504407585604, 9489.288303377274, 10926.672199834018, 11695.005924496343, 11790.882091178979, 11914.821277680841, 644.5455953552735, 644.716324817079, 648.3710800523485, 656.1994366872408, 682.7269092363094, 4926.685053274887, 5094.5669618082875, 5103.617228707862, 5131.204663277198, 5158.587313014949, 100239.49880250698, 100639.99360006306, 102826.71732826807, 103241.0, 104754.4762276199, 87954.52386547215, 88210.0, 88782.0, 89889.0, 91718.08281917228, 50888.710008049726, 59489.13320634145, 70921.0, 71583.0, 76557.61721191359, 10345.948270258601, 11787.469563869476, 12310.322932238812, 12365.876341236473, 12460.12779105454, 37384.439233412064, 37791.2441751158, 37973.81013094917, 38558.228835423695, 39440.81677549678, 61668.0, 63363.0, 64203.35796641974, 65358.346416537126, 66669.0, 16666.916665416597, 16718.49844504667, 16792.0, 16820.915895420443, 17003.40488082911, 15257.465988690343, 17977.550561236072, 18216.271349145885, 18314.084295785426, 18472.630547389246, 13881.444742210198, 16390.67218655644, 16469.505914822574, 16511.917440412722, 16654.00075995444, 16501.58746031359, 16542.66914661724, 16577.751333729764, 16606.750898736285, 16628.667426651642, 16172.110533920748, 16336.428225012067, 16377.263023163749, 16379.672406552041, 16392.016479011298, 11660.591879284184, 11927.986121179796, 12052.51789928393, 12095.032397408362, 12270.693232669255, 11411.858814118521, 11790.587329443772, 12226.694332641755, 12369.62891113268, 12548.996080313736], "value": 8180.268827865396, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 111.0, 109.0, 112.0, 111.0, 109.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 93.0, 136.0, 188.0, 139.0, 109.0, 109.0, 108.0, 137.0, 111.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 185.0, 186.0, 186.0, 187.0, 184.0, 186.0, 180.0, 183.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 62.0, 88.0, 117.0, 89.0, 78.0, 58.0, 58.0, 83.0, 56.0], "value": 76.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 87.0, 69.0, 67.0, 68.0, 108.0, 100.0, 101.0, 90.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 90.0, 113.0, 88.0, 87.0, 89.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 85.0, 81.0, 83.0, 84.0, 84.0, 86.0, 85.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 49.0, 49.0, 49.0, 47.0, 47.0, 49.0, 48.0], "value": 48.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 59.0, 55.0, 66.0, 61.0, 59.0, 57.0, 56.0, 55.0, 56.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 85.0, 82.0, 83.0, 83.0, 82.0, 81.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 139.0, 133.0, 134.0, 146.0, 136.0, 135.0, 177.0, 143.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 191.0, 184.0, 186.0, 181.0, 184.0, 188.0, 182.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 67.0, 67.0, 68.0, 71.0, 68.0, 68.0, 67.0], "value": 67.9, "unit": "score"}]}]} 21:29:50 INFO - Return code: 0 21:29:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:29:50 ERROR - # TBPL SUCCESS # 21:29:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:29:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:29:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:29:50 INFO - 2017-04-23 21:29:50.897 screenresolution[1654:10665] starting screenresolution argv=screenresolution get 21:29:50 INFO - 2017-04-23 21:29:50.899 screenresolution[1654:10665] Display 0: 1600x1200x32@60 21:29:50 INFO - 2017-04-23 21:29:50.905 screenresolution[1655:10668] starting screenresolution argv=screenresolution list 21:29:50 INFO - Available Modes on Display 0 21:29:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:29:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:29:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:29:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:29:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:29:51 INFO - Intel Iris: 21:29:51 INFO - Chipset Model: Intel Iris 21:29:51 INFO - Type: GPU 21:29:51 INFO - Bus: Built-In 21:29:51 INFO - VRAM (Dynamic, Max): 1536 MB 21:29:51 INFO - Vendor: Intel (0x8086) 21:29:51 INFO - Device ID: 0x0a2e 21:29:51 INFO - Revision ID: 0x0009 21:29:51 INFO - Displays: 21:29:51 INFO - Display: 21:29:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:29:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:29:51 INFO - Display Serial Number: 1600x1200 60 21:29:51 INFO - Main Display: Yes 21:29:51 INFO - Mirror: Off 21:29:51 INFO - Online: Yes 21:29:51 INFO - Rotation: Supported 21:29:51 INFO - Return code: 0 21:29:51 INFO - Running post-action listener: _resource_record_post_action 21:29:51 INFO - [mozharness: 2017-04-24 04:29:51.144606Z] Finished run-tests step (success) 21:29:51 INFO - Running post-run listener: _resource_record_post_run 21:29:51 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 31681536; Write bytes: 514662912; Read time: 325; Write time: 1860 21:29:51 INFO - TinderboxPrint: CPU usage
53.4% 21:29:51 INFO - TinderboxPrint: I/O read bytes / time
31,681,536 / 325 21:29:51 INFO - TinderboxPrint: I/O write bytes / time
514,662,912 / 1,860 21:29:51 INFO - TinderboxPrint: CPU idle
2,237.1 (46.6%) 21:29:51 INFO - TinderboxPrint: CPU system
954.4 (19.9%) 21:29:51 INFO - TinderboxPrint: CPU user
1,606.2 (33.5%) 21:29:51 INFO - TinderboxPrint: Swap in / out
235,958,272 / 0 21:29:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196700672; Write bytes: 196305408; Read time: 14879; Write time: 469 21:29:51 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 30751744; Write bytes: 301535232; Read time: 307; Write time: 1340 21:29:51 INFO - Running post-run listener: _upload_blobber_files 21:29:51 INFO - Blob upload gear active. 21:29:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29:51 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 21:29:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:29:52 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:52 INFO - (blobuploader) - INFO - Done attempting. 21:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:53 INFO - (blobuploader) - INFO - Done attempting. 21:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:54 INFO - (blobuploader) - INFO - Done attempting. 21:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:57 INFO - (blobuploader) - INFO - Done attempting. 21:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:57 INFO - Return code: 0 21:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10abc08645fc3b7d48209a75f4681d042cf21f782a9e89bbd565118e2d0972a1fd93e1b557db6372dfdb42694baacee63a219c8679939e1e63ec4fa871fc81d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33fda645a001b81d9bccf55a2050ec5fa8f943370d2fe94f3d0e4e4973473b4e525c2282e933f6abdbdf3642eec8547700249ccb0bbc44c8d045a3cb8505f31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d3401cc41b9c090856dd6f2de42efcce78437a54dfb6f04d08b15f18a61f89d831c7757cda9c98e7f751a14cdecab1998cca9fcf3ff5d48681450b854697e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764b13326f0b2de9823b8d86f4399ac906bb669b218348d80ff1805614755c24ede428fdb9635ea6ce8ff920c16290f616d1c8bf4dd46cccc88b2ab44c761185"} 21:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:57 INFO - Contents: 21:29:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10abc08645fc3b7d48209a75f4681d042cf21f782a9e89bbd565118e2d0972a1fd93e1b557db6372dfdb42694baacee63a219c8679939e1e63ec4fa871fc81d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33fda645a001b81d9bccf55a2050ec5fa8f943370d2fe94f3d0e4e4973473b4e525c2282e933f6abdbdf3642eec8547700249ccb0bbc44c8d045a3cb8505f31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d3401cc41b9c090856dd6f2de42efcce78437a54dfb6f04d08b15f18a61f89d831c7757cda9c98e7f751a14cdecab1998cca9fcf3ff5d48681450b854697e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764b13326f0b2de9823b8d86f4399ac906bb669b218348d80ff1805614755c24ede428fdb9635ea6ce8ff920c16290f616d1c8bf4dd46cccc88b2ab44c761185"} 21:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:57 INFO - Copying logs to upload dir... 21:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.018753 ========= master_lag: 0.99 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-23 21:29:58.136092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 21:29:58.139405) ========= 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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10abc08645fc3b7d48209a75f4681d042cf21f782a9e89bbd565118e2d0972a1fd93e1b557db6372dfdb42694baacee63a219c8679939e1e63ec4fa871fc81d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33fda645a001b81d9bccf55a2050ec5fa8f943370d2fe94f3d0e4e4973473b4e525c2282e933f6abdbdf3642eec8547700249ccb0bbc44c8d045a3cb8505f31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d3401cc41b9c090856dd6f2de42efcce78437a54dfb6f04d08b15f18a61f89d831c7757cda9c98e7f751a14cdecab1998cca9fcf3ff5d48681450b854697e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764b13326f0b2de9823b8d86f4399ac906bb669b218348d80ff1805614755c24ede428fdb9635ea6ce8ff920c16290f616d1c8bf4dd46cccc88b2ab44c761185"} build_url:https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010907 build_url: 'https://queue.taskcluster.net/v1/task/SJgi2CZDRKGm8tfy6GW2zQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10abc08645fc3b7d48209a75f4681d042cf21f782a9e89bbd565118e2d0972a1fd93e1b557db6372dfdb42694baacee63a219c8679939e1e63ec4fa871fc81d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33fda645a001b81d9bccf55a2050ec5fa8f943370d2fe94f3d0e4e4973473b4e525c2282e933f6abdbdf3642eec8547700249ccb0bbc44c8d045a3cb8505f31c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d3401cc41b9c090856dd6f2de42efcce78437a54dfb6f04d08b15f18a61f89d831c7757cda9c98e7f751a14cdecab1998cca9fcf3ff5d48681450b854697e1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/764b13326f0b2de9823b8d86f4399ac906bb669b218348d80ff1805614755c24ede428fdb9635ea6ce8ff920c16290f616d1c8bf4dd46cccc88b2ab44c761185"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 21:29:58.180392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 21:29:58.180718) ========= 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.L4kfAUB1bY/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.HUm0vHbYBk/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 21:29:58.229758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 21:29:58.230082) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 21:29:58.230399) ========= ========= Total master_lag: 1.13 =========