builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0070 starttime: 1476978195.36 results: success (0) buildid: 20161020060950 builduid: 1bbe4c412e9648bbb7ba3be3e9117da8 revision: 6d612f9ed26a6e352fe80a37c91906e3ac56d9e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.362845) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.363271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.363561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.387828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.388177) ========= 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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 --2016-10-20 08:43:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-10-20 08:43:15 (50.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129276 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.544598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.547961) ========= 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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.026655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:15.606557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-10-20 08:43:15.606905) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6d612f9ed26a6e352fe80a37c91906e3ac56d9e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6d612f9ed26a6e352fe80a37c91906e3ac56d9e2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.38BnZEYxiH/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.qnsMp3SEHJ/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 2016-10-20 08:43:15,682 truncating revision to first 12 chars 2016-10-20 08:43:15,682 Setting DEBUG logging. 2016-10-20 08:43:15,682 attempt 1/10 2016-10-20 08:43:15,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6d612f9ed26a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 08:43:16,798 unpacking tar archive at: mozilla-aurora-6d612f9ed26a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.497735 ========= master_lag: 3.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-10-20 08:43:20.634082) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:20.634354) ========= script_repo_revision: 6d612f9ed26a6e352fe80a37c91906e3ac56d9e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:20.634738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:20.638017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 08:43:20.663763) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-20 08:43:20.664103) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.38BnZEYxiH/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.qnsMp3SEHJ/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:20 INFO - MultiFileLogger online at 20161020 08:43:20 in /builds/slave/test 08:43:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:43:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:20 INFO - {'append_to_log': False, 08:43:20 INFO - 'base_work_dir': '/builds/slave/test', 08:43:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:43:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:20 INFO - 'branch': 'Mozilla-Aurora', 08:43:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:20 INFO - 'config_files': ('talos/mac_config.py',), 08:43:20 INFO - 'default_actions': ('clobber', 08:43:20 INFO - 'read-buildbot-config', 08:43:20 INFO - 'download-and-extract', 08:43:20 INFO - 'populate-webroot', 08:43:20 INFO - 'create-virtualenv', 08:43:20 INFO - 'install', 08:43:20 INFO - 'run-tests'), 08:43:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:20 INFO - 'download_minidump_stackwalk': True, 08:43:20 INFO - 'download_symbols': 'ondemand', 08:43:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:20 INFO - 'installer_path': 'installer.exe', 08:43:20 INFO - 'log_level': 'info', 08:43:20 INFO - 'log_name': 'talos', 08:43:20 INFO - 'log_to_console': True, 08:43:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:43:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:43:20 INFO - 'opt_config_files': (), 08:43:20 INFO - 'pip_index': False, 08:43:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:20 INFO - 'cmd': ('bash', 08:43:20 INFO - '-c', 08:43:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:20 INFO - 'enabled': True, 08:43:20 INFO - 'halt_on_failure': False, 08:43:20 INFO - 'name': 'check_screen_resolution'},), 08:43:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:20 INFO - 'cmd': ('bash', 08:43:20 INFO - '-c', 08:43:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:20 INFO - 'enabled': True, 08:43:20 INFO - 'halt_on_failure': False, 08:43:20 INFO - 'name': 'check_screen_resolution'},), 08:43:20 INFO - 'run_cmd_checks_enabled': True, 08:43:20 INFO - 'sps_profile': False, 08:43:20 INFO - 'sps_profile_interval': 0, 08:43:20 INFO - 'suite': 'dromaeojs', 08:43:20 INFO - 'system_bits': '32', 08:43:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:20 INFO - 'title': 't-yosemite-r7-0070', 08:43:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:20 INFO - 'use_talos_json': True, 08:43:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:20 INFO - 'work_dir': 'build'} 08:43:20 INFO - [mozharness: 2016-10-20 15:43:20.862560Z] Running clobber step. 08:43:20 INFO - Running pre-action listener: _resource_record_pre_action 08:43:20 INFO - Running main action method: clobber 08:43:20 INFO - rmtree: /builds/slave/test/build 08:43:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:22 INFO - Running post-action listener: _resource_record_post_action 08:43:22 INFO - [mozharness: 2016-10-20 15:43:22.978371Z] Finished clobber step (success) 08:43:22 INFO - [mozharness: 2016-10-20 15:43:22.978606Z] Running read-buildbot-config step. 08:43:22 INFO - Running pre-action listener: _resource_record_pre_action 08:43:22 INFO - Running main action method: read_buildbot_config 08:43:22 INFO - Using buildbot properties: 08:43:22 INFO - { 08:43:22 INFO - "project": "", 08:43:22 INFO - "product": "firefox", 08:43:22 INFO - "script_repo_revision": "production", 08:43:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:43:22 INFO - "repository": "", 08:43:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:43:22 INFO - "buildid": "20161020060950", 08:43:22 INFO - "pgo_build": "False", 08:43:22 INFO - "basedir": "/builds/slave/test", 08:43:22 INFO - "buildnumber": 97, 08:43:22 INFO - "slavename": "t-yosemite-r7-0070", 08:43:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:43:22 INFO - "platform": "yosemite_r7", 08:43:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:43:22 INFO - "branch": "mozilla-aurora", 08:43:22 INFO - "repo_path": "releases/mozilla-aurora", 08:43:22 INFO - "revision": "6d612f9ed26a6e352fe80a37c91906e3ac56d9e2", 08:43:22 INFO - "stage_platform": "macosx64", 08:43:22 INFO - "builduid": "1bbe4c412e9648bbb7ba3be3e9117da8", 08:43:22 INFO - "slavebuilddir": "test" 08:43:22 INFO - } 08:43:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 08:43:22 INFO - Running post-action listener: _resource_record_post_action 08:43:22 INFO - [mozharness: 2016-10-20 15:43:22.984380Z] Finished read-buildbot-config step (success) 08:43:22 INFO - [mozharness: 2016-10-20 15:43:22.984603Z] Running download-and-extract step. 08:43:22 INFO - Running pre-action listener: _resource_record_pre_action 08:43:22 INFO - Running main action method: download_and_extract 08:43:22 INFO - mkdir: /builds/slave/test/build/tests 08:43: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')]} 08:43:22 INFO - trying https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 08:43:22 INFO - Downloading https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 08:43:24 INFO - Downloaded 1199 bytes. 08:43:24 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:43:24 INFO - Using the following test package requirements: 08:43:24 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:43:24 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 08:43:24 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 08:43:24 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'jsshell-mac.zip'], 08:43:24 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 08:43:24 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:43:24 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 08:43:24 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 08:43:24 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 08:43:24 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:43:24 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 08:43:24 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:43:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:43:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:43:24 INFO - Fetch https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:43:24 INFO - Expected file size: 16436235 08:43:31 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:43:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:43:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:43:31 INFO - Fetch https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:43:32 INFO - Expected file size: 16436235 08:43:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 08:43:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:43:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 08:43:40 INFO - Expected file size: 14414081 08:43: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')]} 08:43:40 INFO - trying https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:43:40 INFO - Downloading https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 08:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 08:43:43 INFO - Downloaded 115425507 bytes. 08:43:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:43:43 INFO - mkdir: /builds/slave/test/properties 08:43:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:43 INFO - Contents: 08:43:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:43:44 INFO - Running post-action listener: _resource_record_post_action 08:43:44 INFO - Running post-action listener: set_extra_try_arguments 08:43:44 INFO - [mozharness: 2016-10-20 15:43:44.291248Z] Finished download-and-extract step (success) 08:43:44 INFO - [mozharness: 2016-10-20 15:43:44.291370Z] Running populate-webroot step. 08:43:44 INFO - Running pre-action listener: _resource_record_pre_action 08:43:44 INFO - Running main action method: populate_webroot 08:43:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:44 INFO - '--tppagecycles', 08:43:44 INFO - '7'], 08:43:44 INFO - 'tests': ['tsvgm']}}, 08:43:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['damp', 'tps']}, 08:43:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'tests': ['damp', 'tps']}, 08:43:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['dromaeo_dom']}, 08:43:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['basic_compositor_video']}, 08:43:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['a11yr', 08:43:44 INFO - 'ts_paint', 08:43:44 INFO - 'tpaint', 08:43:44 INFO - 'sessionrestore', 08:43:44 INFO - 'sessionrestore_no_auto_restore', 08:43:44 INFO - 'tabpaint']}, 08:43:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:44 INFO - 'ts_paint', 08:43:44 INFO - 'tpaint', 08:43:44 INFO - 'sessionrestore', 08:43:44 INFO - 'sessionrestore_no_auto_restore', 08:43:44 INFO - 'tabpaint']}, 08:43:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:44 INFO - 'ts_paint', 08:43:44 INFO - 'tpaint', 08:43:44 INFO - 'sessionrestore', 08:43:44 INFO - 'sessionrestore_no_auto_restore', 08:43:44 INFO - 'tabpaint']}, 08:43:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:44 INFO - 'ts_paint', 08:43:44 INFO - 'tpaint', 08:43:44 INFO - 'sessionrestore', 08:43:44 INFO - 'sessionrestore_no_auto_restore', 08:43:44 INFO - 'tabpaint']}, 08:43:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['a11yr', 08:43:44 INFO - 'ts_paint', 08:43:44 INFO - 'tpaint', 08:43:44 INFO - 'sessionrestore', 08:43:44 INFO - 'sessionrestore_no_auto_restore', 08:43:44 INFO - 'tabpaint']}, 08:43:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['a11yr', 08:43:44 INFO - 'ts_paint', 08:43:44 INFO - 'tpaint', 08:43:44 INFO - 'sessionrestore', 08:43:44 INFO - 'sessionrestore_no_auto_restore', 08:43:44 INFO - 'tabpaint']}, 08:43:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['tsvgx', 08:43:44 INFO - 'tsvgr_opacity', 08:43:44 INFO - 'tart', 08:43:44 INFO - 'tscrollx', 08:43:44 INFO - 'cart']}, 08:43:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:44 INFO - 'tsvgr_opacity', 08:43:44 INFO - 'tart', 08:43:44 INFO - 'tscrollx', 08:43:44 INFO - 'cart']}, 08:43:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'talos_options': ['--disable-e10s'], 08:43:44 INFO - 'tests': ['tp5o']}, 08:43:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'tests': ['tp5o']}, 08:43:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'talos_options': ['--disable-e10s', 08:43:44 INFO - '--xperf_path', 08:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:44 INFO - 'tests': ['tp5n']}, 08:43:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:44 INFO - 'talos_options': ['--xperf_path', 08:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:44 INFO - 'tests': ['tp5n']}}, 08:43:44 INFO - 'talos.zip': {'path': '', 08:43:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:44 INFO - Running post-action listener: _resource_record_post_action 08:43:44 INFO - [mozharness: 2016-10-20 15:43:44.309862Z] Finished populate-webroot step (success) 08:43:44 INFO - [mozharness: 2016-10-20 15:43:44.310002Z] Running create-virtualenv step. 08:43:44 INFO - Running pre-action listener: _resource_record_pre_action 08:43:44 INFO - Running main action method: create_virtualenv 08:43:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:44 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 08:43:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:44 INFO - Using real prefix '/tools/python27' 08:43:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:48 INFO - Installing pip.................done. 08:43:48 INFO - Return code: 0 08:43:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:48 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 08:43:48 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 08:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:48 INFO - 'HOME': '/Users/cltbld', 08:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:48 INFO - 'LOGNAME': 'cltbld', 08:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:48 INFO - 'MOZ_NO_REMOTE': '1', 08:43:48 INFO - 'NO_EM_RESTART': '1', 08:43:48 INFO - 'PAGER': '/bin/cat', 08:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:48 INFO - 'PWD': '/builds/slave/test', 08:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:48 INFO - 'SHELL': '/bin/bash', 08:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:43:48 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:48 INFO - 'USER': 'cltbld', 08:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:48 INFO - 'XPC_FLAGS': '0x0', 08:43:48 INFO - 'XPC_SERVICE_NAME': '0', 08:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:48 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 08:43:48 INFO - Cleaning up... 08:43:48 INFO - Return code: 0 08:43:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:48 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:48 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 08:43:48 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 08:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:48 INFO - 'HOME': '/Users/cltbld', 08:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:48 INFO - 'LOGNAME': 'cltbld', 08:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:48 INFO - 'MOZ_NO_REMOTE': '1', 08:43:48 INFO - 'NO_EM_RESTART': '1', 08:43:48 INFO - 'PAGER': '/bin/cat', 08:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:48 INFO - 'PWD': '/builds/slave/test', 08:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:48 INFO - 'SHELL': '/bin/bash', 08:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:43:48 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:48 INFO - 'USER': 'cltbld', 08:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:48 INFO - 'XPC_FLAGS': '0x0', 08:43:48 INFO - 'XPC_SERVICE_NAME': '0', 08:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:48 INFO - Downloading/unpacking psutil>=3.1.1 08:43:48 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 08:43:48 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 08:43:48 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 08:43:48 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 08:43:48 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 08:43:48 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 08:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:51 INFO - Installing collected packages: psutil 08:43:51 INFO - Running setup.py install for psutil 08:43:51 INFO - building 'psutil._psutil_osx' extension 08:43:51 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 08:43:52 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 08:43:52 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 08:43:52 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 08:43:52 INFO - building 'psutil._psutil_posix' extension 08:43:52 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 08:43:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:43:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:43:52 INFO - ^ 08:43:52 INFO - 1 warning generated. 08:43:52 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 08:43:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:52 INFO - Successfully installed psutil 08:43:52 INFO - Cleaning up... 08:43:52 INFO - Return code: 0 08:43:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:52 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:52 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 08:43:52 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 08:43:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:43:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:52 INFO - 'HOME': '/Users/cltbld', 08:43:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:52 INFO - 'LOGNAME': 'cltbld', 08:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:52 INFO - 'MOZ_NO_REMOTE': '1', 08:43:52 INFO - 'NO_EM_RESTART': '1', 08:43:52 INFO - 'PAGER': '/bin/cat', 08:43:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:52 INFO - 'PWD': '/builds/slave/test', 08:43:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:52 INFO - 'SHELL': '/bin/bash', 08:43:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:43:52 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:43:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:52 INFO - 'USER': 'cltbld', 08:43:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:52 INFO - 'XPC_FLAGS': '0x0', 08:43:52 INFO - 'XPC_SERVICE_NAME': '0', 08:43:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:53 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 08:43:53 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 08:43:53 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 08:43:53 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 08:43:53 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 08:43:53 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 08:43:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:55 INFO - Installing collected packages: mozsystemmonitor 08:43:55 INFO - Running setup.py install for mozsystemmonitor 08:43:55 INFO - Successfully installed mozsystemmonitor 08:43:55 INFO - Cleaning up... 08:43:55 INFO - Return code: 0 08:43:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:55 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')]} 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 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')]} 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:55 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 08:43:55 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 08:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:55 INFO - 'HOME': '/Users/cltbld', 08:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:55 INFO - 'LOGNAME': 'cltbld', 08:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:55 INFO - 'MOZ_NO_REMOTE': '1', 08:43:55 INFO - 'NO_EM_RESTART': '1', 08:43:55 INFO - 'PAGER': '/bin/cat', 08:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:55 INFO - 'PWD': '/builds/slave/test', 08:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:55 INFO - 'SHELL': '/bin/bash', 08:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:43:55 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:55 INFO - 'USER': 'cltbld', 08:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:55 INFO - 'XPC_FLAGS': '0x0', 08:43:55 INFO - 'XPC_SERVICE_NAME': '0', 08:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:56 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 08:43:56 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 08:43:56 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 08:43:56 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 08:43:56 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 08:43:56 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 08:43:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43:58 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 08:43:58 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 08:43:58 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 08:43:58 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 08:43:58 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 08:43:58 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 08:43:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:59 INFO - warning: no files found matching '*.txt' 08:43:59 INFO - no previously-included directories found matching 'build' 08:43:59 INFO - no previously-included directories found matching 'dist' 08:43:59 INFO - no previously-included directories found matching '.git*' 08:43:59 INFO - Installing collected packages: jsonschema, functools32 08:43:59 INFO - Running setup.py install for functools32 08:43:59 INFO - warning: no files found matching '*.txt' 08:43:59 INFO - no previously-included directories found matching 'build' 08:43:59 INFO - no previously-included directories found matching 'dist' 08:43:59 INFO - no previously-included directories found matching '.git*' 08:43:59 INFO - Successfully installed jsonschema functools32 08:43:59 INFO - Cleaning up... 08:43:59 INFO - Return code: 0 08:43:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:43:59 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')]} 08:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:59 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')]} 08:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:59 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:59 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 08:43:59 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 08:43:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:43:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:59 INFO - 'HOME': '/Users/cltbld', 08:43:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:59 INFO - 'LOGNAME': 'cltbld', 08:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:59 INFO - 'MOZ_NO_REMOTE': '1', 08:43:59 INFO - 'NO_EM_RESTART': '1', 08:43:59 INFO - 'PAGER': '/bin/cat', 08:43:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:59 INFO - 'PWD': '/builds/slave/test', 08:43:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:59 INFO - 'SHELL': '/bin/bash', 08:43:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:43:59 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:43:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:59 INFO - 'USER': 'cltbld', 08:43:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:59 INFO - 'XPC_FLAGS': '0x0', 08:43:59 INFO - 'XPC_SERVICE_NAME': '0', 08:43:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:43:59 INFO - Cleaning up... 08:43:59 INFO - Return code: 0 08:43:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:59 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')]} 08:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:59 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')]} 08:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:59 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:43:59 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 08:43:59 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 08:43:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:43:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:59 INFO - 'HOME': '/Users/cltbld', 08:43:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:59 INFO - 'LOGNAME': 'cltbld', 08:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:59 INFO - 'MOZ_NO_REMOTE': '1', 08:43:59 INFO - 'NO_EM_RESTART': '1', 08:43:59 INFO - 'PAGER': '/bin/cat', 08:43:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:59 INFO - 'PWD': '/builds/slave/test', 08:43:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:59 INFO - 'SHELL': '/bin/bash', 08:43:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:43:59 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:43:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:59 INFO - 'USER': 'cltbld', 08:43:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:59 INFO - 'XPC_FLAGS': '0x0', 08:43:59 INFO - 'XPC_SERVICE_NAME': '0', 08:43:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:00 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 08:44:00 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 08:44:00 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 08:44:00 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 08:44:00 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 08:44:00 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 08:44:02 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:02 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 08:44:02 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 08:44:02 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 08:44:02 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 08:44:02 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 08:44:02 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 08:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:03 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 08:44:03 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 08:44:03 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 08:44:03 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 08:44:03 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 08:44:03 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 08:44:03 INFO - Downloading docopt-0.6.1.tar.gz 08:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:03 INFO - Running setup.py install for blobuploader 08:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:04 INFO - Running setup.py install for requests 08:44:04 INFO - Running setup.py install for docopt 08:44:04 INFO - Successfully installed blobuploader requests docopt 08:44:04 INFO - Cleaning up... 08:44:04 INFO - Return code: 0 08:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:04 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:44:04 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 08:44:04 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 08:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:04 INFO - 'HOME': '/Users/cltbld', 08:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:04 INFO - 'LOGNAME': 'cltbld', 08:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:04 INFO - 'MOZ_NO_REMOTE': '1', 08:44:04 INFO - 'NO_EM_RESTART': '1', 08:44:04 INFO - 'PAGER': '/bin/cat', 08:44:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:04 INFO - 'PWD': '/builds/slave/test', 08:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:04 INFO - 'SHELL': '/bin/bash', 08:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:44:04 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:04 INFO - 'USER': 'cltbld', 08:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:04 INFO - 'XPC_FLAGS': '0x0', 08:44:04 INFO - 'XPC_SERVICE_NAME': '0', 08:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-wOl3Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-p6mxYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-g4XLOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-PMJK7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-1IbGMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-TE9dIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-k56vQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-XvfnFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Jo0aMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:05 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-1dTAbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-V11Nw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-_1LMyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JS6iqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-CbwsxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-ufxRCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-W0miaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:06 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-4GPtdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:06 INFO - Running setup.py install for manifestparser 08:44:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:06 INFO - Running setup.py install for mozcrash 08:44:07 INFO - Running setup.py install for mozdebug 08:44:07 INFO - Running setup.py install for mozdevice 08:44:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Running setup.py install for mozfile 08:44:07 INFO - Running setup.py install for mozhttpd 08:44:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Running setup.py install for mozinfo 08:44:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Running setup.py install for mozInstall 08:44:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:07 INFO - Running setup.py install for mozleak 08:44:08 INFO - Running setup.py install for mozlog 08:44:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:08 INFO - Running setup.py install for moznetwork 08:44:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:08 INFO - Running setup.py install for mozprocess 08:44:08 INFO - Running setup.py install for mozprofile 08:44:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:08 INFO - Running setup.py install for mozrunner 08:44:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:08 INFO - Running setup.py install for mozscreenshot 08:44:09 INFO - Running setup.py install for moztest 08:44:09 INFO - Running setup.py install for mozversion 08:44:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:09 INFO - Cleaning up... 08:44:09 INFO - Return code: 0 08:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:09 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:44:09 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 08:44:09 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 08:44:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:44:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:09 INFO - 'HOME': '/Users/cltbld', 08:44:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:09 INFO - 'LOGNAME': 'cltbld', 08:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:09 INFO - 'MOZ_NO_REMOTE': '1', 08:44:09 INFO - 'NO_EM_RESTART': '1', 08:44:09 INFO - 'PAGER': '/bin/cat', 08:44:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:09 INFO - 'PWD': '/builds/slave/test', 08:44:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:09 INFO - 'SHELL': '/bin/bash', 08:44:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:44:09 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:44:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:09 INFO - 'USER': 'cltbld', 08:44:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:09 INFO - 'XPC_FLAGS': '0x0', 08:44:09 INFO - 'XPC_SERVICE_NAME': '0', 08:44:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-h73Esr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:10 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-9rhGoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-AsLIx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:10 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-2coW9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-D7g9LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:10 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5a8oYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:10 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-G2wLvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:10 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-9TxYko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:10 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)) 08:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:10 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-iPXguP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:11 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-l5vneq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:11 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-deC3Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:11 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-zvuELw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-J7nmCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:11 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-NPLSi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-67CeKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:11 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-bfoH4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:11 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5QObB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:11 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)) 08:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:11 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)) 08:44:11 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:11 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:14 INFO - Downloading blessings-1.6.tar.gz 08:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:14 INFO - Installing collected packages: blessings 08:44:14 INFO - Running setup.py install for blessings 08:44:15 INFO - Successfully installed blessings 08:44:15 INFO - Cleaning up... 08:44:15 INFO - Return code: 0 08:44:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:15 INFO - Reading from file tmpfile_stdout 08:44:15 INFO - Current package versions: 08:44:15 INFO - blessings == 1.6 08:44:15 INFO - blobuploader == 1.2.4 08:44:15 INFO - docopt == 0.6.1 08:44:15 INFO - functools32 == 3.2.3-2 08:44:15 INFO - jsonschema == 2.5.1 08:44:15 INFO - manifestparser == 1.1 08:44:15 INFO - mozInstall == 1.12 08:44:15 INFO - mozcrash == 0.17 08:44:15 INFO - mozdebug == 0.1 08:44:15 INFO - mozdevice == 0.48 08:44:15 INFO - mozfile == 1.2 08:44:15 INFO - mozhttpd == 0.7 08:44:15 INFO - mozinfo == 0.9 08:44:15 INFO - mozleak == 0.1 08:44:15 INFO - mozlog == 3.4 08:44:15 INFO - moznetwork == 0.27 08:44:15 INFO - mozprocess == 0.23 08:44:15 INFO - mozprofile == 0.28 08:44:15 INFO - mozrunner == 6.12 08:44:15 INFO - mozscreenshot == 0.1 08:44:15 INFO - mozsystemmonitor == 0.3 08:44:15 INFO - moztest == 0.7 08:44:15 INFO - mozversion == 1.4 08:44:15 INFO - psutil == 3.1.1 08:44:15 INFO - requests == 1.2.3 08:44:15 INFO - wsgiref == 0.1.2 08:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:15 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 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:44:15 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 08:44:15 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 08:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:15 INFO - 'HOME': '/Users/cltbld', 08:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:15 INFO - 'LOGNAME': 'cltbld', 08:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:15 INFO - 'MOZ_NO_REMOTE': '1', 08:44:15 INFO - 'NO_EM_RESTART': '1', 08:44:15 INFO - 'PAGER': '/bin/cat', 08:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:15 INFO - 'PWD': '/builds/slave/test', 08:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:15 INFO - 'SHELL': '/bin/bash', 08:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:44:15 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:15 INFO - 'USER': 'cltbld', 08:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:15 INFO - 'XPC_FLAGS': '0x0', 08:44:15 INFO - 'XPC_SERVICE_NAME': '0', 08:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 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)) 08:44:15 INFO - Cleaning up... 08:44:15 INFO - Return code: 0 08:44:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e90490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e06570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4914537f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, '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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 08:44:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:15 INFO - 'HOME': '/Users/cltbld', 08:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:15 INFO - 'LOGNAME': 'cltbld', 08:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:15 INFO - 'MOZ_NO_REMOTE': '1', 08:44:15 INFO - 'NO_EM_RESTART': '1', 08:44:15 INFO - 'PAGER': '/bin/cat', 08:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:15 INFO - 'PWD': '/builds/slave/test', 08:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:15 INFO - 'SHELL': '/bin/bash', 08:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:44:15 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:15 INFO - 'USER': 'cltbld', 08:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:15 INFO - 'XPC_FLAGS': '0x0', 08:44:15 INFO - 'XPC_SERVICE_NAME': '0', 08:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:15 INFO - Cleaning up... 08:44:15 INFO - Return code: 0 08:44:15 INFO - Running post-action listener: _resource_record_post_action 08:44:15 INFO - Running post-action listener: _start_resource_monitoring 08:44:15 INFO - Starting resource monitoring. 08:44:15 INFO - [mozharness: 2016-10-20 15:44:15.976561Z] Finished create-virtualenv step (success) 08:44:15 INFO - [mozharness: 2016-10-20 15:44:15.977475Z] Running install step. 08:44:15 INFO - Running pre-action listener: _resource_record_pre_action 08:44:15 INFO - Running main action method: install 08:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:16 INFO - Reading from file tmpfile_stdout 08:44:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:16 INFO - Reading from file tmpfile_stdout 08:44:16 INFO - Output received: 08:44:16 INFO - Usage: mozinstall [options] installer 08:44:16 INFO - Options: 08:44:16 INFO - -h, --help show this help message and exit 08:44:16 INFO - -d DEST, --destination=DEST 08:44:16 INFO - Directory to install application into. [default: 08:44:16 INFO - "/builds/slave/test"] 08:44:16 INFO - --app=APP Application being installed. [default: firefox] 08:44:16 INFO - mkdir: /builds/slave/test/build/application 08:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:44:48 INFO - Reading from file tmpfile_stdout 08:44:48 INFO - Output received: 08:44:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:44:48 INFO - Running post-action listener: _resource_record_post_action 08:44:48 INFO - [mozharness: 2016-10-20 15:44:48.785136Z] Finished install step (success) 08:44:48 INFO - [mozharness: 2016-10-20 15:44:48.785273Z] Running run-tests step. 08:44:48 INFO - Running pre-action listener: _resource_record_pre_action 08:44:48 INFO - Running main action method: run_tests 08:44:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:48 INFO - 2016-10-20 08:44:48.799 screenresolution[1644:7898] starting screenresolution argv=screenresolution get 08:44:48 INFO - 2016-10-20 08:44:48.802 screenresolution[1644:7898] Display 0: 1600x1200x32@60 08:44:48 INFO - 2016-10-20 08:44:48.808 screenresolution[1645:7900] starting screenresolution argv=screenresolution list 08:44:48 INFO - Available Modes on Display 0 08:44:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:49 INFO - Intel Iris: 08:44:49 INFO - Chipset Model: Intel Iris 08:44:49 INFO - Type: GPU 08:44:49 INFO - Bus: Built-In 08:44:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:49 INFO - Vendor: Intel (0x8086) 08:44:49 INFO - Device ID: 0x0a2e 08:44:49 INFO - Revision ID: 0x0009 08:44:49 INFO - Displays: 08:44:49 INFO - Display: 08:44:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:49 INFO - Display Serial Number: 1600x1200 60 08:44:49 INFO - Main Display: Yes 08:44:49 INFO - Mirror: Off 08:44:49 INFO - Online: Yes 08:44:49 INFO - Rotation: Supported 08:44:49 INFO - Return code: 0 08:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:49 INFO - Python 2.7.3 08:44:49 INFO - Return code: 0 08:44:49 INFO - grabbing minidump binary from tooltool 08:44:49 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')]} 08:44:49 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 0x107ca4d30>, '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 0x107b0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c9cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:49 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 08:44:49 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 08:44:49 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 08:44:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:49 INFO - Return code: 0 08:44:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:44:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:44:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 08:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --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 08:44:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.38BnZEYxiH/Render', 08:44:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:49 INFO - 'HOME': '/Users/cltbld', 08:44:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:49 INFO - 'LOGNAME': 'cltbld', 08:44:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:49 INFO - 'MOZ_NO_REMOTE': '1', 08:44:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:49 INFO - 'NO_EM_RESTART': '1', 08:44:49 INFO - 'PAGER': '/bin/cat', 08:44:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:49 INFO - 'PWD': '/builds/slave/test', 08:44:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:49 INFO - 'SHELL': '/bin/bash', 08:44:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qnsMp3SEHJ/Listeners', 08:44:49 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 08:44:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:49 INFO - 'USER': 'cltbld', 08:44:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:49 INFO - 'XPC_FLAGS': '0x0', 08:44:49 INFO - 'XPC_SERVICE_NAME': '0', 08:44:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 08:44:49 INFO - mozversion application_buildid: 20161020060950 08:44:49 INFO - mozversion application_changeset: 6d612f9ed26a6e352fe80a37c91906e3ac56d9e2 08:44:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:44:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:49 INFO - mozversion application_name: Firefox 08:44:49 INFO - mozversion application_remotingname: firefox-dev 08:44:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:44:49 INFO - mozversion application_vendor: Mozilla 08:44:49 INFO - mozversion application_version: 51.0a2 08:44:49 INFO - mozversion platform_buildid: 20161020060950 08:44:49 INFO - mozversion platform_changeset: 6d612f9ed26a6e352fe80a37c91906e3ac56d9e2 08:44:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:44:49 INFO - mozversion platform_version: 51.0a2 08:44:49 INFO - using testdate: 1476978289 08:44:49 INFO - actual date: 1476978289 08:44:49 INFO - starting webserver on 'localhost:49273' 08:44:49 INFO - SUITE-START | Running 2 tests 08:44:49 INFO - TEST-START | dromaeo_css 08:44:49 INFO - operating with platform_type : mac_ 08:44:49 INFO - Initialising browser for dromaeo_css test... 08:44:49 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpI5h9lf/profile http://localhost:49273/getInfo.html) 08:44:51 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 08:44:51 INFO - PROCESS | 1655 | colorDepth:24 08:44:51 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 08:44:51 INFO - PROCESS | 1655 | __metrics 08:44:52 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:44:52 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:52 INFO - TEST-INFO | 1655: exit 0 08:44:52 INFO - Browser initialized. 08:44:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:52 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpI5h9lf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:04 INFO - PROCESS | 1660 | RSS: Main: 219951104 08:45:04 INFO - PROCESS | 1660 | 08:45:55 INFO - PROCESS | 1660 | 1476978355695 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:48:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 08:48:09 INFO - PROCESS | 1660 | RSS: Main: 369451008 08:48:09 INFO - PROCESS | 1660 | 08:51:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 08:51:12 INFO - PROCESS | 1660 | RSS: Main: 350326784 08:51:12 INFO - PROCESS | 1660 | 08:54:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 08:54:15 INFO - PROCESS | 1660 | RSS: Main: 315351040 08:54:15 INFO - PROCESS | 1660 | 08:57:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 08:57:18 INFO - PROCESS | 1660 | RSS: Main: 322183168 08:57:18 INFO - PROCESS | 1660 | 09:00:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 09:00:22 INFO - PROCESS | 1660 | RSS: Main: 312471552 09:00:22 INFO - PROCESS | 1660 | 09:03:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 09:03:26 INFO - PROCESS | 1660 | RSS: Main: 418537472 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | __start_tp_report 09:03:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 09:03:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 09:03:26 INFO - PROCESS | 1660 | |i|pagename|runs| 09:03:26 INFO - PROCESS | 1660 | |0;dojo.html;3320.169957510622;3346.514755360473;3369.4608862581977;3381.797092174468;3408.795472271664;5621.971890140549;5673.375928647845;5675.517581005614;5694.800681976131;5728.627639203449;5614.522765564931;5630.239917611121;5708.315002199732;5711.2575365202465;5719.971400143004;5194.35070616173;5207.947920520794;5208.5051920067535;5239.1093514102695;5245;5144.819931302405;5152.201408781645;5157.510036546522;5281.2342210379475;5292.259083728281;5205.271262023301;5205.3233079699585;5209.088409528336;5212.50481204285;5224.582033437335;5219.42586315505;5223.843284701465;5281;5286.233496143076;5345.625806193568;5087.338645976037;5121.334226550562;5177.042247184283;5194.844154675366;5215.921761173586;5523.917141242885;5572.3870374258795;5588.580856435784;5614.466625670596;5638.633488823213;6146.508279337642;6162.506999440034;6198.380161983766;6247.687615619201;6250.093736408196;6268.247810262752;6294.529706428201;6306.3378345274;6320.431161195468;6321.905171422432;5645.774169033234;5677.37548869624;5705.971470142623;5789.218455508537;5807.128930660435;6267.843303917347;6333.018382150774;6341.23905131378;6342.080398342215;6352.650604216812;6171.166892469549;6184.443400094013;6189.50483961282;6189.752409903644;6190.164327815777;6041.5468839837185;6130.417610327012;6138.6722360735575;6178.938210617926;6331.398517140864;6117.510599152057;6151.169592105009;6157.168782214433;6158.507319414436;6168.722407491674;6142.508599312045;6194.721237544321;6199.504039676815;6215.223097112861;6236.719347629277;4829.879253018632;4880.780364883589;4882.438519570295;4943.604511639061;4962.8759281018265;4429.047754732748;4432.069265454226;4469.061497085649;4480.395146655225;4524.16302983949;5739.598228123991;5746.080627099644;5748.166515855178;5754.856128596819;5759.769609215668;6310;6327.841803954846;6332.52506062038;6340.809775706736;6344.175257216532;5525.723713814374;5623.381428042912;5645.463680950304;5656.717164141859;5691.971540142273;5374.11327131019;5398.036806153289;5412.539934105645;5437.966786310589;5445.700486473282;6313.053042043638;6339.90490142639;6346.428821406095;6352.301246862841;6360.204974378203;6138.416850399205;6251.6874156292915;6253.843653908689;6304.369563043659;6319.431251187415;6279.96860015697;6303.212098487689;6318.747250109944;6352.968235158794;6372.490200784019;6231.376862313732;6257.186565746424;6262.15460912771;6263.091851681572;6279.183706118175;6256.968715156395;6262.906056409249;6291.96854015727;6315.463185629273;6327.209098862642;5950.761969521171;5974.103884417372;6004.129401236709;6006.849828754316;6155.322914479493;6082.817515474543;6088.178095956989;6090.23872015998;6105.114758360101;6141.048137538689;5891.911621325769;5901;5904.734286957011;5915.970420147872;5926.170336152856;5283.181106928432;5670.950874088307;5911.55663325261;6019.759209631741;6060.818175454743;5881.05903055509;5962.910556341745;5970.3432622412365;6024.096385542204;6029.668368239789 09:03:26 INFO - PROCESS | 1660 | |1;ext.html;494.0736119775421;515.9871003224919;536.6055948877577;550.4577990679182;550.8349840088213;30907.536386954213;33147.00558983231;42191;42414.36378454325;44151.0132044058;40750.59249407505;43833.12333753331;44023.23907043714;44024.11951760963;44024.679259622186;9844.40933543988;10011.649592264272;10023.548940297704;10023.599056037787;10042.397456152617;9815;9907.157891579225;9915.206783457306;9917.107460328569;9923.801523969516;9825.705228843146;9900.108990190882;9967;9968.800623987516;9986.900130998705;9864.852027219562;9915.603375865028;9919.057689519484;9928.205743540535;9934.25493088014;9924;9991.90008099917;9996.400215987063;9999.450030248334;10004.39973601579;41531.377029344585;41716.582834171575;41754.582454175375;41818.58181418208;42023.7898810507;3307.5038744188323;3326.700596946262;3328.1845947742718;3402.4896265560365;3515.5605549306338;25536.21246512745;30323.848380758176;30765.846170769226;32288.6771132288;32597.837010814794;2981.8658160382834;3088.089013740952;3088.2125058110264;3152.1646763607664;3192.776505644606;387061;387633;387980;389432;394936;34260.48609270863;34511.30977380438;34891.30217395638;64143.22710955943;64345.67827160928;36117;36270;36307;36323;36773.63226367756;14968.326425310886;15138.016028958082;15140.167290799112;15150.3182356792;15155.848441515664;12836;12907.806382904264;12948;12953;12978.480860765463;7822.374210063182;7852.018497687789;7853;7931.246531579491;7937;3145.6382516010954;3191.7606179536165;3195.9360812783616;3215.276562773404;3257.110875692093;855.9884271960842;891.5765011619559;897.1118592593416;962.6823148361024;980.1913421427208;30215.546766798514;30806.845965770026;31004.68995310063;31638.683613164034;31859.52210716841;1035.6892932120484;1068.060107105742;1075.9462026898623;1101.730076131353;1142.5030111901349;15451.38194472231;16034;16146.596335091717;16216.027038377735;16389.67220655604;710616;718097;718102;718851;719504;60026.699866500385;60489.69755151284;60524;60553;60587;1166.5567084507832;1183.9758608803322;1250.7185883176212;1296.8962483001526;1298.9805152922713;31118.22204444907;32065;32286;32920.34159316848;33046.339073218885;52250;57668.423315767985;58615.70692146512;58713.4128658725;61497;669825;676860;677424;677985;680565;37200;37515.623593876684;41078.58921410747;44625.776871115435;45236.54763452323;47277.054458909945;48553.514464856315;48711.025779484924;49274.26088608602;49317.50682493129;33486.497702534;39358.01604959899;40449.59550404576;42148.789256053526;43262.78004703552;31593.36813263676;33520.44667269816;40248.597514024485;40693.79653101716;41967.37048944207;35061.82469087638;39235;39298.2140357197;39542.60457395389;39838.804835853814;30364;32692.182695432806;35474.64525354713;35656.108597285274;36217.45673814842;21737;25079.620620866026;26239.081632142785;26374.076907308154;26415.33961650974 09:03:26 INFO - PROCESS | 1660 | |2;jquery.html;346.4318517631084;361.3459638055119;368.6240035164132;377.3415390144199;395.70519962627844;15050.247487625616;15396.69206615867;16200.270987805532;20940;21302.57394852102;15598.610034749108;20003;20618;20907.895460522675;21263.893680531615;5067.391912970439;6077.513798896078;6086.117512960618;6106.572539922207;6152.077188421727;4825.710457372551;6165.722542485577;6197.256329240475;6228.283747369065;6239.469645080174;5808.1578171165365;6177.660228687443;6181.690915454232;6192.473639740628;6196.81409557714;6003.729832157564;6152.907706384408;6190.226221722285;6194.876102477971;6208.813735587917;4642.442906851199;5699.031164702011;5958.910616340759;6007.309159446676;6014.338422773491;10785.298955567863;12920.676983075404;12973.027022973314;13202.801957970638;13216.008799339992;2101.6112019276484;2215.313252891609;2258.9495884413664;2401.183597576815;2694.488047271032;9755.365901216399;9849.21206303494;9851.704448866545;10377.740556486073;10387.169026477864;1812.746215529827;1866.2908094923978;1892.990535047316;1907.551725344543;1914.5405102775233;90644.09355906422;117301;123859;125992;128918.99999999907;11199.10407167441;11399.259048161843;11453.083753299716;11518.251313664585;11678.299302041905;14346.928265358607;14375.424983000563;14388.208648524222;14390.136591804525;14394.280285985658;8491.108433614381;8603.612837422332;8641.222289993932;8650.91349086501;8761.737147885573;8676.913230867736;8685.652573896974;8692.217700406994;8801.295896328278;8823.823523529622;4447.844325448594;4456.420665313489;4470.977645111753;4504.909901801946;4574.839880604163;1846.9076546172637;1881.8870867747705;1882.981170188308;1912.5218695326168;1919.4145785535545;818.4802650316973;874.3660845886808;904.7240591619619;912.8721978922956;958.3674774648838;20629;21898.01458934352;21902.342929711816;22031.66952495714;22037.559248814934;797.6729540888208;880.8106257154742;899.545773916133;906.3836591118103;998.3510718033336;10599.311044782064;11439.88560114405;11552.075833933266;11567.248128871764;11588.420578971018;530267;549899;556891;570138;570498;124615;125477.49045019048;129964;130421;130887.34556327158;890.7773056735816;898.2454738020094;920.963161473547;923.9630414783468;924.7919218175991;15659.765103523228;18797.06014699287;19289.324873629357;19520.707189392455;19543.60912781765;42307.576924231595;52804.47195528149;54392;55045.44954550403;55691;76638.08404789925;76763.61618191874;78545;79287.60356198181;79726;7165.928340716526;7530.472866899484;7902.0912595052305;8157.592120394075;8175.1416101308505;10435.791284174122;12754.979601632032;12830.935845320713;13064;13172.934135329262;9054.547272636473;9951.701448956543;10346.586136554453;11175.944120279346;11464.656060318204;10541.57833686644;10555.894441055798;10783.946080269548;10945.890541094486;11114.49984750672;9130.634774609207;10296.661434013531;10709.303895246783;10786.406747628957;11141.72145696364;7662.195469475625;7844.137144914169;7968.681252750057;8034.879476807736;8063.475874068166;7487.6630551626395;8872.64509419616;9526.333156678966;10546;10855.511501982272 09:03:26 INFO - PROCESS | 1660 | |3;mootools.html;1248.5754843353259;1363.6795353092027;1504.285464404408;1625.9918700406497;1855.7587513623218;7773.6501857416415;8251.793705157366;8631.438956467833;8860.734177974655;8888.555572221396;8750.299976001921;8839;8842.292616590674;8844.38089333747;8891;2382.4996750682376;2410.240774156144;2411.2284069097896;2411.577973854577;2413.879306034691;2364.47981444082;2394.8922298496523;2400.8919598618018;2404.338806828119;2405.915792947247;2373.0507796881298;2387;2389.6296074108454;2402.435427674504;2406.4826062396583;2341.1220792202926;2358.2335740884196;2359.9410014749596;2371.1937941100023;2379.5240951809706;2329.219711396684;2355.305184970438;2360.280114565057;2360.586897292967;2361.858288502678;8769.693060742908;8771.298296136294;8851.734447966572;8852.778680533038;8861.468311901242;5147.639665223436;5355.866103347408;5383.703896285702;5384.569234461273;5397.946020539823;3368.4105281575626;3520.4543295789194;3563.073600863768;3597.388443964532;3600.243948770735;1019.6176433837311;1046.633678212627;1048.6749107776614;1070.9410982395966;1072.1369297715414;11519.884801151966;11550.422478876106;11597.072234221241;11622.651320460314;11630.953214210762;3845;4487.506374298824;4542.250528662799;4647.02501436888;4656.068786242698;8915.331350148765;9016.819663606691;9067.773305667411;9073.54632268384;9079.546022698838;5207.0887594670785;5207.401148867929;5214.739263036909;5216.686998780086;5222.112240919053;4327.221100201994;4371.453568303962;4531.728096314232;4535.909281814345;4892.119418504703;3759.342115129841;3779.1874746928993;3844.0774214188395;3848.191879705237;3862.0537968197973;994.9054839790208;995.6714284286168;1166.1545379599722;1184.8400465936988;1187.0562902492538;633.5818359882547;815.975520734379;898.7258886039821;909.2498688581815;932.47315266874;5692.345380281321;5773.566982476331;5871.1486834409625;5957.4638282553915;6026.186464827192;937.3532262738688;938.9201917837061;939.6758118449125;950.6720181537358;997.0627610046533;3664.2305115925956;3739.383001804726;3948.9605103949166;3979.2439436507548;3998.3802510610903;10382.169426445866;10606.57573697059;10617.628383006559;10780.676579702622;10796.730081748019;10613.893861061444;10738.94630526858;10741.83887241692;10747.89252107469;10774.78450430987;7793.4154938378715;8156.592170391456;8333.208345207195;8363.95818020906;8369.079401265855;4955.331030310862;5847.561432892635;6110.969445152924;6191.566590338633;6211.627302361872;8748.47509149453;9626.47054412014;9759.707208783748;10070.798584028425;10085.344452610558;9755.414675119515;9780.41317520951;9900.207983361457;9904.603815847286;10160.949195253976;7947.44367894265;8112.918870811216;8233.876491852747;8248.793780155544;8335.291500222549;8214.301784348398;8271.131531189138;8383.03595086573;8395.538245396561;8404.243618074403;7454.329110380092;7476.140243871807;7525.36034437079;7527.322540971339;7547.886781698388;7171.42628589722;7191.676374563052;7215.386692131017;7236.638168091679;7248.782536523912;6910.170779506491;6976.232614412512;7046.647667616701;7064.858702826017;7092.290770923073;4989.201727723546;5017.347744793154;5020.096382651158;5043;5045.9243111352625;4801.447833499193;4845.6608037438455;4853.587445067209;4952.232403977389;4970.478099799614 09:03:26 INFO - PROCESS | 1660 | |4;prototype.html;279.44948451550465;297.1871930270709;300.9082229919875;305.71263012768003;311.5420332111795;4967.435257893765;5064.797408103676;5128.871778205542;5244.868878278045;5250.579953603712;4403.6477081833455;5180.326557547513;5185.403678576965;5200.453952335007;5202.52285904049;3531.629178936213;3939.8921576956263;3997.98001009996;4018.3369743992207;4043.796131108553;3792.222594368148;3939.369700847865;4019;4026.6174713402324;4043.6360727534516;3838.7888666123354;3865.362215234497;3997.6002399759936;4004.899877503057;4022.4971878515184;3304.4712845944773;3402.9829850850833;3975.284448799215;3985.083430810915;4019.135885784541;3448.2069323951655;3448.3448144852396;3473.645278341449;3486.7210623150086;3502.176988407722;4460.996275837943;4829.9231330527855;5000.349604946424;5215;5216.60875434344;3894.6494815466463;4541.250693635546;4567.292069729164;4595.770211489412;4610.423697037871;5101.438841727407;5506.944930550723;5525.408484485077;5537.889242215173;5573.832785016456;3555.6977656899194;3765.435184722286;3789.696824254053;3796.4115562087923;3801.182745709658;5748.511376533;5785.971070144665;5803.245578074865;5808.431723434691;5828.6502809831545;3485.4074807282823;3678.429843374281;3887.8639247626197;3889.649931506178;3892.630200130983;3133.9843300783805;3582.902640033491;3882.456456096149;3914.432407300925;3915.5105611798526;3399.5070714746716;4393.340998850134;4404.273294906368;4431.135928493913;4604.240300350405;5054.9274797333655;5524.58565607573;5530.198121272473;5545.500904918576;5553.194786755897;1303.882650561435;1320.586971940015;1322.6957799706122;1329.634350553586;1331.8601546837442;692.4495026453981;747.3834086878347;806.9233422824823;813.4021494201756;822.7696245051395;3956.645795751523;4301.591348821857;4307.396964424983;4346.6522678185665;4350.543192964757;4458.4426946631675;4674.027076984604;4687.156311863897;4714.457837348748;4729.6689231754135;4099.446574712376;4241.745495270232;4250.553691862372;4304.4834619845815;4409.919569705443;2069.927552535654;2362.7164740231283;2435.659007738918;2488.8631125288284;2500.437401584665;3770.981145094257;4725.4565724941385;4843.757812109451;4918.385201849769;4920.162273426733;4037.8208554146318;4285.46431696038;4353.804078816461;4438.866833994985;4833.782479788418;4200.348945913388;4537.727736335831;4784.569388755029;4819.638527110551;4942.5304596063315;4149.522804877357;4430.313301438282;4656.41794775653;4691.343211950398;4702.929456058094;3647.7264205184188;3848.5766565677195;4454.933176002427;4697.788599513098;4714.996126646231;4065.837366505307;4464.196444639996;4781.545753153445;4831.806727730992;4958.7024778513405;2668.4129491511835;3127.7185053345306;3205.7435405168;3289.4999800151577;3296.604407471119;4267.50923643785;4282.8715138545895;4657.883552911204;4748.501407352178;4766.046790641816;4032.415299781574;4866.880617457934;5272.821103193689;5389.137737961907;5501;4608.723476591415;5012.899742005213;5549.611527193219;5554.666719996813;5581.7767289309595;5203.27154198405;5410.431904649955;5469.917951230815;5505.697186654773;5562.749676264497;4436.489803672619;5088.338515992898;5608.971955140361;5680.4662741058855;5744.396838331915;4621.376114224537;4850.587700045536;5526.50261476469;5540.22436858832;5547.972260138674 09:03:26 INFO - PROCESS | 1660 | |5;yui.html;622.6139793328138;637.9585326953749;677.7661706711186;715.9391451726603;716.1263258824235;12900.935495322534;13067.150635208705;14101.153930764136;14256.501022464203;14322.641933951643;12702.17435866668;12932.28872412017;12954.287514186715;12957.870421295807;13007.479700811957;679.3274658088507;828.2131974624101;845.71245776436;847.1359213602123;851.4720873058712;685.7736946807566;694.0110342761544;694.6665600511758;696.7282759723712;697.7557854750822;867.8698195270697;899.9965038981521;901.2294488212582;909.3725329522641;911.7994041310934;892.6161750447305;895.1451363947415;895.3598177303194;898.5597057441806;899.3749344205779;524.9553787928031;657.6120089147378;658.6245839871275;659.1233659233209;660.5343233020709;11746.765064698659;13418.597442076752;13946.302684865715;13997.230152341617;14206.360713767905;12847.29339886306;13094.869051309555;13247.668808279774;13305.40125694346;13596.456141754317;9316.720498385059;10357.430341331225;10573.524191411405;10813.351198928089;11092.223544351898;3248.204189973448;3259.788113772597;3271.1985563536846;3278.278778668689;3300.8349582520777;115166;115710.42144789307;115936.42031789871;117783.93296402243;119525;9898.851517227247;9974.152197063186;10238.232132590085;10306.690799276033;10529.578816847394;18971;20131;20183.596328073356;20524.38426847197;20525.794742052687;6035.36628653985;6952.409045231111;7072.646367681596;7194.136703595497;7252.3835473984245;3857.459955606161;3971.2653159165648;3984.143409167043;4004.2391945530258;4008.819603117867;3198.440272952224;3375.6118046424485;3380.7295416366633;3386.983065084659;3391.745619078579;600.741681077141;604.652324913168;609.4636719686736;609.8414412252757;616.8642898562309;580.1558732044865;599.2928344553382;601.5247954116287;612.1216054961145;634.3497914637534;7141.785746427616;8669.783255418664;8725.825483490295;8729.65081396737;8908.465492070496;603.9560614502857;629.0972454527767;631.0439683878927;631.6778442994106;647.5661306924372;3604.387254166798;4043.1509383029893;4341.544137865479;4385.502896836815;4391.5827996340295;87566.12433875707;154122;158459;165165.17417412836;166249.16875415546;84284;88431;89097;141086.2945685265;142331;106247.4687626557;111973.44013279882;114618.42690786492;115749;120806;8169.2647661710735;8389.580520974048;8407.411481196257;8528.91471085306;8590;66147;66147.6692616553;67763.66118169378;69242;69412;80984.38031239224;91793.08206917845;97090.0290997081;101414.49292753488;102732;10703.625373111903;12444.502219911103;12622.431990560262;12624.116311858083;12894;13665.385057672229;13959.581212563638;14722.63193420173;14885.404583816526;14893.627659308604;11226.607068752555;11400.543978240778;11876.049916006526;12203.511859525875;12470.563530276397;11146.331220126818;11275;13101.148425352703;13929.512467063603;14022;12807.527134379294;12926.935365323114;13122.868771312547;13145.60563183106;14084.859151408764;10711.730333505597;11060.889391105986;11388.772224555629;11528.941167152037;11983.520659173535;11362.602308919148;11521.251118677259;11590;11672.299662020307;11775.175737698279 09:03:26 INFO - PROCESS | 1660 | __end_tp_report 09:03:26 INFO - PROCESS | 1660 | __start_cc_report 09:03:26 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1467 09:03:26 INFO - PROCESS | 1660 | __end_cc_report 09:03:26 INFO - PROCESS | 1660 | __startTimestamp1476979406033__endTimestamp 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | ------- Summary: start ------- 09:03:26 INFO - PROCESS | 1660 | Number of tests: 6 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5738.78 Median:5915.97 stddev:640.61 (10.8%) stddev-sans-first:613.84 09:03:26 INFO - PROCESS | 1660 | Values: 3320.2 3346.5 3369.5 3381.8 3408.8 5622.0 5673.4 5675.5 5694.8 5728.6 5614.5 5630.2 5708.3 5711.3 5720.0 5194.4 5207.9 5208.5 5239.1 5245.0 5144.8 5152.2 5157.5 5281.2 5292.3 5205.3 5205.3 5209.1 5212.5 5224.6 5219.4 5223.8 5281.0 5286.2 5345.6 5087.3 5121.3 5177.0 5194.8 5215.9 5523.9 5572.4 5588.6 5614.5 5638.6 6146.5 6162.5 6198.4 6247.7 6250.1 6268.2 6294.5 6306.3 6320.4 6321.9 5645.8 5677.4 5706.0 5789.2 5807.1 6267.8 6333.0 6341.2 6342.1 6352.7 6171.2 6184.4 6189.5 6189.8 6190.2 6041.5 6130.4 6138.7 6178.9 6331.4 6117.5 6151.2 6157.2 6158.5 6168.7 6142.5 6194.7 6199.5 6215.2 6236.7 4829.9 4880.8 4882.4 4943.6 4962.9 4429.0 4432.1 4469.1 4480.4 4524.2 5739.6 5746.1 5748.2 5754.9 5759.8 6310.0 6327.8 6332.5 6340.8 6344.2 5525.7 5623.4 5645.5 5656.7 5692.0 5374.1 5398.0 5412.5 5438.0 5445.7 6313.1 6339.9 6346.4 6352.3 6360.2 6138.4 6251.7 6253.8 6304.4 6319.4 6280.0 6303.2 6318.7 6353.0 6372.5 6231.4 6257.2 6262.2 6263.1 6279.2 6257.0 6262.9 6292.0 6315.5 6327.2 5950.8 5974.1 6004.1 6006.8 6155.3 6082.8 6088.2 6090.2 6105.1 6141.0 5891.9 5901.0 5904.7 5916.0 5926.2 5283.2 5671.0 5911.6 6019.8 6060.8 5881.1 5962.9 5970.3 6024.1 6029.7 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:71704.86 Median:39266.61 stddev:164503.65 (418.9%) stddev-sans-first:164878.24 09:03:26 INFO - PROCESS | 1660 | Values: 494.1 516.0 536.6 550.5 550.8 30907.5 33147.0 42191.0 42414.4 44151.0 40750.6 43833.1 44023.2 44024.1 44024.7 9844.4 10011.6 10023.5 10023.6 10042.4 9815.0 9907.2 9915.2 9917.1 9923.8 9825.7 9900.1 9967.0 9968.8 9986.9 9864.9 9915.6 9919.1 9928.2 9934.3 9924.0 9991.9 9996.4 9999.5 10004.4 41531.4 41716.6 41754.6 41818.6 42023.8 3307.5 3326.7 3328.2 3402.5 3515.6 25536.2 30323.8 30765.8 32288.7 32597.8 2981.9 3088.1 3088.2 3152.2 3192.8 387061.0 387633.0 387980.0 389432.0 394936.0 34260.5 34511.3 34891.3 64143.2 64345.7 36117.0 36270.0 36307.0 36323.0 36773.6 14968.3 15138.0 15140.2 15150.3 15155.8 12836.0 12907.8 12948.0 12953.0 12978.5 7822.4 7852.0 7853.0 7931.2 7937.0 3145.6 3191.8 3195.9 3215.3 3257.1 856.0 891.6 897.1 962.7 980.2 30215.5 30806.8 31004.7 31638.7 31859.5 1035.7 1068.1 1075.9 1101.7 1142.5 15451.4 16034.0 16146.6 16216.0 16389.7 710616.0 718097.0 718102.0 718851.0 719504.0 60026.7 60489.7 60524.0 60553.0 60587.0 1166.6 1184.0 1250.7 1296.9 1299.0 31118.2 32065.0 32286.0 32920.3 33046.3 52250.0 57668.4 58615.7 58713.4 61497.0 669825.0 676860.0 677424.0 677985.0 680565.0 37200.0 37515.6 41078.6 44625.8 45236.5 47277.1 48553.5 48711.0 49274.3 49317.5 33486.5 39358.0 40449.6 42148.8 43262.8 31593.4 33520.4 40248.6 40693.8 41967.4 35061.8 39235.0 39298.2 39542.6 39838.8 30364.0 32692.2 35474.6 35656.1 36217.5 21737.0 25079.6 26239.1 26374.1 26415.3 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33304.18 Median:23377.71 stddev:93282.37 (399.0%) stddev-sans-first:93511.23 09:03:26 INFO - PROCESS | 1660 | Values: 346.4 361.3 368.6 377.3 395.7 15050.2 15396.7 16200.3 20940.0 21302.6 15598.6 20003.0 20618.0 20907.9 21263.9 5067.4 6077.5 6086.1 6106.6 6152.1 4825.7 6165.7 6197.3 6228.3 6239.5 5808.2 6177.7 6181.7 6192.5 6196.8 6003.7 6152.9 6190.2 6194.9 6208.8 4642.4 5699.0 5958.9 6007.3 6014.3 10785.3 12920.7 12973.0 13202.8 13216.0 2101.6 2215.3 2258.9 2401.2 2694.5 9755.4 9849.2 9851.7 10377.7 10387.2 1812.7 1866.3 1893.0 1907.6 1914.5 90644.1 117301.0 123859.0 125992.0 128919.0 11199.1 11399.3 11453.1 11518.3 11678.3 14346.9 14375.4 14388.2 14390.1 14394.3 8491.1 8603.6 8641.2 8650.9 8761.7 8676.9 8685.7 8692.2 8801.3 8823.8 4447.8 4456.4 4471.0 4504.9 4574.8 1846.9 1881.9 1883.0 1912.5 1919.4 818.5 874.4 904.7 912.9 958.4 20629.0 21898.0 21902.3 22031.7 22037.6 797.7 880.8 899.5 906.4 998.4 10599.3 11439.9 11552.1 11567.2 11588.4 530267.0 549899.0 556891.0 570138.0 570498.0 124615.0 125477.5 129964.0 130421.0 130887.3 890.8 898.2 921.0 924.0 924.8 15659.8 18797.1 19289.3 19520.7 19543.6 42307.6 52804.5 54392.0 55045.4 55691.0 76638.1 76763.6 78545.0 79287.6 79726.0 7165.9 7530.5 7902.1 8157.6 8175.1 10435.8 12755.0 12830.9 13064.0 13172.9 9054.5 9951.7 10346.6 11175.9 11464.7 10541.6 10555.9 10783.9 10945.9 11114.5 9130.6 10296.7 10709.3 10786.4 11141.7 7662.2 7844.1 7968.7 8034.9 8063.5 7487.7 8872.6 9526.3 10546.0 10855.5 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5662.74 Median:5044.46 stddev:3175.85 (63.0%) stddev-sans-first:3167.43 09:03:26 INFO - PROCESS | 1660 | Values: 1248.6 1363.7 1504.3 1626.0 1855.8 7773.7 8251.8 8631.4 8860.7 8888.6 8750.3 8839.0 8842.3 8844.4 8891.0 2382.5 2410.2 2411.2 2411.6 2413.9 2364.5 2394.9 2400.9 2404.3 2405.9 2373.1 2387.0 2389.6 2402.4 2406.5 2341.1 2358.2 2359.9 2371.2 2379.5 2329.2 2355.3 2360.3 2360.6 2361.9 8769.7 8771.3 8851.7 8852.8 8861.5 5147.6 5355.9 5383.7 5384.6 5397.9 3368.4 3520.5 3563.1 3597.4 3600.2 1019.6 1046.6 1048.7 1070.9 1072.1 11519.9 11550.4 11597.1 11622.7 11631.0 3845.0 4487.5 4542.3 4647.0 4656.1 8915.3 9016.8 9067.8 9073.5 9079.5 5207.1 5207.4 5214.7 5216.7 5222.1 4327.2 4371.5 4531.7 4535.9 4892.1 3759.3 3779.2 3844.1 3848.2 3862.1 994.9 995.7 1166.2 1184.8 1187.1 633.6 816.0 898.7 909.2 932.5 5692.3 5773.6 5871.1 5957.5 6026.2 937.4 938.9 939.7 950.7 997.1 3664.2 3739.4 3949.0 3979.2 3998.4 10382.2 10606.6 10617.6 10780.7 10796.7 10613.9 10738.9 10741.8 10747.9 10774.8 7793.4 8156.6 8333.2 8364.0 8369.1 4955.3 5847.6 6111.0 6191.6 6211.6 8748.5 9626.5 9759.7 10070.8 10085.3 9755.4 9780.4 9900.2 9904.6 10160.9 7947.4 8112.9 8233.9 8248.8 8335.3 8214.3 8271.1 8383.0 8395.5 8404.2 7454.3 7476.1 7525.4 7527.3 7547.9 7171.4 7191.7 7215.4 7236.6 7248.8 6910.2 6976.2 7046.6 7064.9 7092.3 4989.2 5017.3 5020.1 5043.0 5045.9 4801.4 4845.7 4853.6 4952.2 4970.5 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4156.59 Median:4446.90 stddev:1275.42 (28.7%) stddev-sans-first:1245.36 09:03:26 INFO - PROCESS | 1660 | Values: 279.4 297.2 300.9 305.7 311.5 4967.4 5064.8 5128.9 5244.9 5250.6 4403.6 5180.3 5185.4 5200.5 5202.5 3531.6 3939.9 3998.0 4018.3 4043.8 3792.2 3939.4 4019.0 4026.6 4043.6 3838.8 3865.4 3997.6 4004.9 4022.5 3304.5 3403.0 3975.3 3985.1 4019.1 3448.2 3448.3 3473.6 3486.7 3502.2 4461.0 4829.9 5000.3 5215.0 5216.6 3894.6 4541.3 4567.3 4595.8 4610.4 5101.4 5506.9 5525.4 5537.9 5573.8 3555.7 3765.4 3789.7 3796.4 3801.2 5748.5 5786.0 5803.2 5808.4 5828.7 3485.4 3678.4 3887.9 3889.6 3892.6 3134.0 3582.9 3882.5 3914.4 3915.5 3399.5 4393.3 4404.3 4431.1 4604.2 5054.9 5524.6 5530.2 5545.5 5553.2 1303.9 1320.6 1322.7 1329.6 1331.9 692.4 747.4 806.9 813.4 822.8 3956.6 4301.6 4307.4 4346.7 4350.5 4458.4 4674.0 4687.2 4714.5 4729.7 4099.4 4241.7 4250.6 4304.5 4409.9 2069.9 2362.7 2435.7 2488.9 2500.4 3771.0 4725.5 4843.8 4918.4 4920.2 4037.8 4285.5 4353.8 4438.9 4833.8 4200.3 4537.7 4784.6 4819.6 4942.5 4149.5 4430.3 4656.4 4691.3 4702.9 3647.7 3848.6 4454.9 4697.8 4715.0 4065.8 4464.2 4781.5 4831.8 4958.7 2668.4 3127.7 3205.7 3289.5 3296.6 4267.5 4282.9 4657.9 4748.5 4766.0 4032.4 4866.9 5272.8 5389.1 5501.0 4608.7 5012.9 5549.6 5554.7 5581.8 5203.3 5410.4 5469.9 5505.7 5562.7 4436.5 5088.3 5609.0 5680.5 5744.4 4621.4 4850.6 5526.5 5540.2 5548.0 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:24302.87 Median:3338.22 stddev:39759.57 (1191.0%) stddev-sans-first:39831.35 09:03:26 INFO - PROCESS | 1660 | Values: 622.6 638.0 677.8 715.9 716.1 12900.9 13067.2 14101.2 14256.5 14322.6 12702.2 12932.3 12954.3 12957.9 13007.5 679.3 828.2 845.7 847.1 851.5 685.8 694.0 694.7 696.7 697.8 867.9 900.0 901.2 909.4 911.8 892.6 895.1 895.4 898.6 899.4 525.0 657.6 658.6 659.1 660.5 11746.8 13418.6 13946.3 13997.2 14206.4 12847.3 13094.9 13247.7 13305.4 13596.5 9316.7 10357.4 10573.5 10813.4 11092.2 3248.2 3259.8 3271.2 3278.3 3300.8 115166.0 115710.4 115936.4 117783.9 119525.0 9898.9 9974.2 10238.2 10306.7 10529.6 18971.0 20131.0 20183.6 20524.4 20525.8 6035.4 6952.4 7072.6 7194.1 7252.4 3857.5 3971.3 3984.1 4004.2 4008.8 3198.4 3375.6 3380.7 3387.0 3391.7 600.7 604.7 609.5 609.8 616.9 580.2 599.3 601.5 612.1 634.3 7141.8 8669.8 8725.8 8729.7 8908.5 604.0 629.1 631.0 631.7 647.6 3604.4 4043.2 4341.5 4385.5 4391.6 87566.1 154122.0 158459.0 165165.2 166249.2 84284.0 88431.0 89097.0 141086.3 142331.0 106247.5 111973.4 114618.4 115749.0 120806.0 8169.3 8389.6 8407.4 8528.9 8590.0 66147.0 66147.7 67763.7 69242.0 69412.0 80984.4 91793.1 97090.0 101414.5 102732.0 10703.6 12444.5 12622.4 12624.1 12894.0 13665.4 13959.6 14722.6 14885.4 14893.6 11226.6 11400.5 11876.0 12203.5 12470.6 11146.3 11275.0 13101.1 13929.5 14022.0 12807.5 12926.9 13122.9 13145.6 14084.9 10711.7 11060.9 11388.8 11528.9 11983.5 11362.6 11521.3 11590.0 11672.3 11775.2 09:03:26 INFO - PROCESS | 1660 | -------- Summary: end -------- 09:03:26 INFO - PROCESS | 1660 | 09:03:26 INFO - TEST-INFO | 1660: exit 0 09:03:26 INFO - TEST-OK | dromaeo_css | took 1117268ms 09:03:26 INFO - TEST-START | kraken 09:03:26 INFO - operating with platform_type : mac_ 09:03:26 INFO - Initialising browser for kraken test... 09:03:26 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpofM3PG/profile http://localhost:49273/getInfo.html) 09:03:28 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 09:03:28 INFO - PROCESS | 1667 | colorDepth:24 09:03:28 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 09:03:28 INFO - PROCESS | 1667 | __metrics 09:03:28 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:03:28 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:29 INFO - TEST-INFO | 1667: exit 0 09:03:29 INFO - Browser initialized. 09:03:29 INFO - Running cycle 1/1 for kraken test... 09:03:29 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpofM3PG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:41 INFO - PROCESS | 1668 | RSS: Main: 219209728 09:03:41 INFO - PROCESS | 1668 | 09:03:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:45 INFO - PROCESS | 1668 | RSS: Main: 269959168 09:03:45 INFO - PROCESS | 1668 | 09:03:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 09:03:48 INFO - PROCESS | 1668 | RSS: Main: 280428544 09:03:48 INFO - PROCESS | 1668 | 09:03:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 09:03:52 INFO - PROCESS | 1668 | RSS: Main: 377561088 09:03:52 INFO - PROCESS | 1668 | 09:03:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 09:03:54 INFO - PROCESS | 1668 | RSS: Main: 280477696 09:03:54 INFO - PROCESS | 1668 | 09:03:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:57 INFO - PROCESS | 1668 | RSS: Main: 281161728 09:03:57 INFO - PROCESS | 1668 | 09:04:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:00 INFO - PROCESS | 1668 | RSS: Main: 318550016 09:04:00 INFO - PROCESS | 1668 | 09:04:03 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:04 INFO - PROCESS | 1668 | RSS: Main: 319381504 09:04:04 INFO - PROCESS | 1668 | 09:04:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 09:04:07 INFO - PROCESS | 1668 | RSS: Main: 318443520 09:04:07 INFO - PROCESS | 1668 | 09:04:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:10 INFO - PROCESS | 1668 | RSS: Main: 290263040 09:04:10 INFO - PROCESS | 1668 | 09:04:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:12 INFO - PROCESS | 1668 | RSS: Main: 296067072 09:04:12 INFO - PROCESS | 1668 | 09:04:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:15 INFO - PROCESS | 1668 | RSS: Main: 300191744 09:04:15 INFO - PROCESS | 1668 | 09:04:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:19 INFO - PROCESS | 1668 | RSS: Main: 309788672 09:04:19 INFO - PROCESS | 1668 | 09:04:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:22 INFO - PROCESS | 1668 | RSS: Main: 309100544 09:04:22 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 09:04:24 INFO - PROCESS | 1668 | RSS: Main: 352727040 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | __start_tp_report 09:04:24 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 09:04:24 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 09:04:24 INFO - PROCESS | 1668 | |i|pagename|runs| 09:04:24 INFO - PROCESS | 1668 | |0;ai-astar;116;115;115;115;116;116;114;115;114;115 09:04:24 INFO - PROCESS | 1668 | |1;audio-beat-detection;167;109;109;141;107;113;137;138;139;106 09:04:24 INFO - PROCESS | 1668 | |2;audio-dft;182;184;182;182;185;184;184;186;185;179 09:04:24 INFO - PROCESS | 1668 | |3;audio-fft;81;59;59;88;61;59;59;61;84;69 09:04:24 INFO - PROCESS | 1668 | |4;audio-oscillator;87;71;94;72;68;70;92;67;68;90 09:04:24 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;89;86;89;86;90;85;90;86;88;86 09:04:24 INFO - PROCESS | 1668 | |6;imaging-darkroom;96;97;97;97;97;97;97;97;97;97 09:04:24 INFO - PROCESS | 1668 | |7;imaging-desaturate;84;82;104;133;136;83;83;83;83;85 09:04:24 INFO - PROCESS | 1668 | |8;json-parse-financial;59;55;52;55;55;58;58;58;58;57 09:04:24 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;65;73;71;79;70;69;69;74;100;86 09:04:24 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;83;83;86;82;81;82;80;82;83;87 09:04:24 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;135;143;119;145;143;157;154;136;169;139 09:04:24 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;162;163;159;160;164;163;160;162;164;205 09:04:24 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;55;59;66;68;80;86;86;86;65;66 09:04:24 INFO - PROCESS | 1668 | __end_tp_report 09:04:24 INFO - PROCESS | 1668 | __start_cc_report 09:04:24 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1992 09:04:24 INFO - PROCESS | 1668 | __end_cc_report 09:04:24 INFO - PROCESS | 1668 | __startTimestamp1476979464670__endTimestamp 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | ------- Summary: start ------- 09:04:24 INFO - PROCESS | 1668 | Number of tests: 14 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 09:04:24 INFO - PROCESS | 1668 | Values: 116.0 115.0 115.0 115.0 116.0 116.0 114.0 115.0 114.0 115.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:137.50 stddev:20.67 (15.0%) stddev-sans-first:15.93 09:04:24 INFO - PROCESS | 1668 | Values: 167.0 109.0 109.0 141.0 107.0 113.0 137.0 138.0 139.0 106.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.06 (1.1%) stddev-sans-first:2.13 09:04:24 INFO - PROCESS | 1668 | Values: 182.0 184.0 182.0 182.0 185.0 184.0 184.0 186.0 185.0 179.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:68.00 Median:65.00 stddev:11.78 (18.1%) stddev-sans-first:11.51 09:04:24 INFO - PROCESS | 1668 | Values: 81.0 59.0 59.0 88.0 61.0 59.0 59.0 61.0 84.0 69.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:11.29 (14.2%) stddev-sans-first:11.48 09:04:24 INFO - PROCESS | 1668 | Values: 87.0 71.0 94.0 72.0 68.0 70.0 92.0 67.0 68.0 90.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.90 (2.1%) stddev-sans-first:1.94 09:04:24 INFO - PROCESS | 1668 | Values: 89.0 86.0 89.0 86.0 90.0 85.0 90.0 86.0 88.0 86.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:97.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:04:24 INFO - PROCESS | 1668 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:83.00 stddev:21.52 (25.9%) stddev-sans-first:22.41 09:04:24 INFO - PROCESS | 1668 | Values: 84.0 82.0 104.0 133.0 136.0 83.0 83.0 83.0 83.0 85.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:58.00 stddev:2.17 (3.7%) stddev-sans-first:2.11 09:04:24 INFO - PROCESS | 1668 | Values: 59.0 55.0 52.0 55.0 55.0 58.0 58.0 58.0 58.0 57.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:75.60 Median:72.00 stddev:10.42 (14.5%) stddev-sans-first:10.32 09:04:24 INFO - PROCESS | 1668 | Values: 65.0 73.0 71.0 79.0 70.0 69.0 69.0 74.0 100.0 86.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:2.13 (2.6%) stddev-sans-first:2.26 09:04:24 INFO - PROCESS | 1668 | Values: 83.0 83.0 86.0 82.0 81.0 82.0 80.0 82.0 83.0 87.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:144.00 stddev:13.71 (9.5%) stddev-sans-first:14.15 09:04:24 INFO - PROCESS | 1668 | Values: 135.0 143.0 119.0 145.0 143.0 157.0 154.0 136.0 169.0 139.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:163.00 stddev:13.74 (8.4%) stddev-sans-first:14.49 09:04:24 INFO - PROCESS | 1668 | Values: 162.0 163.0 159.0 160.0 164.0 163.0 160.0 162.0 164.0 205.0 09:04:24 INFO - PROCESS | 1668 | 09:04:24 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:74.00 stddev:11.77 (15.9%) stddev-sans-first:10.82 09:04:24 INFO - PROCESS | 1668 | Values: 55.0 59.0 66.0 68.0 80.0 86.0 86.0 86.0 65.0 66.0 09:04:24 INFO - PROCESS | 1668 | -------- Summary: end -------- 09:04:24 INFO - PROCESS | 1668 | 09:04:25 INFO - TEST-INFO | 1668: exit 0 09:04:25 INFO - TEST-OK | kraken | took 58845ms 09:04:25 INFO - SUITE-END | took 1176s 09:04:25 INFO - Completed test suite (00:19:36) 09:04:25 INFO - javascript benchmark 09:04:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.169957510622, 3346.514755360473, 3369.4608862581977, 3381.797092174468, 3408.795472271664, 5621.971890140549, 5673.375928647845, 5675.517581005614, 5694.800681976131, 5728.627639203449, 5614.522765564931, 5630.239917611121, 5708.315002199732, 5711.2575365202465, 5719.971400143004, 5194.35070616173, 5207.947920520794, 5208.5051920067535, 5239.1093514102695, 5245.0, 5144.819931302405, 5152.201408781645, 5157.510036546522, 5281.2342210379475, 5292.259083728281, 5205.271262023301, 5205.3233079699585, 5209.088409528336, 5212.50481204285, 5224.582033437335, 5219.42586315505, 5223.843284701465, 5281.0, 5286.233496143076, 5345.625806193568, 5087.338645976037, 5121.334226550562, 5177.042247184283, 5194.844154675366, 5215.921761173586, 5523.917141242885, 5572.3870374258795, 5588.580856435784, 5614.466625670596, 5638.633488823213, 6146.508279337642, 6162.506999440034, 6198.380161983766, 6247.687615619201, 6250.093736408196, 6268.247810262752, 6294.529706428201, 6306.3378345274, 6320.431161195468, 6321.905171422432, 5645.774169033234, 5677.37548869624, 5705.971470142623, 5789.218455508537, 5807.128930660435, 6267.843303917347, 6333.018382150774, 6341.23905131378, 6342.080398342215, 6352.650604216812, 6171.166892469549, 6184.443400094013, 6189.50483961282, 6189.752409903644, 6190.164327815777, 6041.5468839837185, 6130.417610327012, 6138.6722360735575, 6178.938210617926, 6331.398517140864, 6117.510599152057, 6151.169592105009, 6157.168782214433, 6158.507319414436, 6168.722407491674, 6142.508599312045, 6194.721237544321, 6199.504039676815, 6215.223097112861, 6236.719347629277, 4829.879253018632, 4880.780364883589, 4882.438519570295, 4943.604511639061, 4962.8759281018265, 4429.047754732748, 4432.069265454226, 4469.061497085649, 4480.395146655225, 4524.16302983949, 5739.598228123991, 5746.080627099644, 5748.166515855178, 5754.856128596819, 5759.769609215668, 6310.0, 6327.841803954846, 6332.52506062038, 6340.809775706736, 6344.175257216532, 5525.723713814374, 5623.381428042912, 5645.463680950304, 5656.717164141859, 5691.971540142273, 5374.11327131019, 5398.036806153289, 5412.539934105645, 5437.966786310589, 5445.700486473282, 6313.053042043638, 6339.90490142639, 6346.428821406095, 6352.301246862841, 6360.204974378203, 6138.416850399205, 6251.6874156292915, 6253.843653908689, 6304.369563043659, 6319.431251187415, 6279.96860015697, 6303.212098487689, 6318.747250109944, 6352.968235158794, 6372.490200784019, 6231.376862313732, 6257.186565746424, 6262.15460912771, 6263.091851681572, 6279.183706118175, 6256.968715156395, 6262.906056409249, 6291.96854015727, 6315.463185629273, 6327.209098862642, 5950.761969521171, 5974.103884417372, 6004.129401236709, 6006.849828754316, 6155.322914479493, 6082.817515474543, 6088.178095956989, 6090.23872015998, 6105.114758360101, 6141.048137538689, 5891.911621325769, 5901.0, 5904.734286957011, 5915.970420147872, 5926.170336152856, 5283.181106928432, 5670.950874088307, 5911.55663325261, 6019.759209631741, 6060.818175454743, 5881.05903055509, 5962.910556341745, 5970.3432622412365, 6024.096385542204, 6029.668368239789], "value": 5697.098848179262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.0736119775421, 515.9871003224919, 536.6055948877577, 550.4577990679182, 550.8349840088213, 30907.536386954213, 33147.00558983231, 42191.0, 42414.36378454325, 44151.0132044058, 40750.59249407505, 43833.12333753331, 44023.23907043714, 44024.11951760963, 44024.679259622186, 9844.40933543988, 10011.649592264272, 10023.548940297704, 10023.599056037787, 10042.397456152617, 9815.0, 9907.157891579225, 9915.206783457306, 9917.107460328569, 9923.801523969516, 9825.705228843146, 9900.108990190882, 9967.0, 9968.800623987516, 9986.900130998705, 9864.852027219562, 9915.603375865028, 9919.057689519484, 9928.205743540535, 9934.25493088014, 9924.0, 9991.90008099917, 9996.400215987063, 9999.450030248334, 10004.39973601579, 41531.377029344585, 41716.582834171575, 41754.582454175375, 41818.58181418208, 42023.7898810507, 3307.5038744188323, 3326.700596946262, 3328.1845947742718, 3402.4896265560365, 3515.5605549306338, 25536.21246512745, 30323.848380758176, 30765.846170769226, 32288.6771132288, 32597.837010814794, 2981.8658160382834, 3088.089013740952, 3088.2125058110264, 3152.1646763607664, 3192.776505644606, 387061.0, 387633.0, 387980.0, 389432.0, 394936.0, 34260.48609270863, 34511.30977380438, 34891.30217395638, 64143.22710955943, 64345.67827160928, 36117.0, 36270.0, 36307.0, 36323.0, 36773.63226367756, 14968.326425310886, 15138.016028958082, 15140.167290799112, 15150.3182356792, 15155.848441515664, 12836.0, 12907.806382904264, 12948.0, 12953.0, 12978.480860765463, 7822.374210063182, 7852.018497687789, 7853.0, 7931.246531579491, 7937.0, 3145.6382516010954, 3191.7606179536165, 3195.9360812783616, 3215.276562773404, 3257.110875692093, 855.9884271960842, 891.5765011619559, 897.1118592593416, 962.6823148361024, 980.1913421427208, 30215.546766798514, 30806.845965770026, 31004.68995310063, 31638.683613164034, 31859.52210716841, 1035.6892932120484, 1068.060107105742, 1075.9462026898623, 1101.730076131353, 1142.5030111901349, 15451.38194472231, 16034.0, 16146.596335091717, 16216.027038377735, 16389.67220655604, 710616.0, 718097.0, 718102.0, 718851.0, 719504.0, 60026.699866500385, 60489.69755151284, 60524.0, 60553.0, 60587.0, 1166.5567084507832, 1183.9758608803322, 1250.7185883176212, 1296.8962483001526, 1298.9805152922713, 31118.22204444907, 32065.0, 32286.0, 32920.34159316848, 33046.339073218885, 52250.0, 57668.423315767985, 58615.70692146512, 58713.4128658725, 61497.0, 669825.0, 676860.0, 677424.0, 677985.0, 680565.0, 37200.0, 37515.623593876684, 41078.58921410747, 44625.776871115435, 45236.54763452323, 47277.054458909945, 48553.514464856315, 48711.025779484924, 49274.26088608602, 49317.50682493129, 33486.497702534, 39358.01604959899, 40449.59550404576, 42148.789256053526, 43262.78004703552, 31593.36813263676, 33520.44667269816, 40248.597514024485, 40693.79653101716, 41967.37048944207, 35061.82469087638, 39235.0, 39298.2140357197, 39542.60457395389, 39838.804835853814, 30364.0, 32692.182695432806, 35474.64525354713, 35656.108597285274, 36217.45673814842, 21737.0, 25079.620620866026, 26239.081632142785, 26374.076907308154, 26415.33961650974], "value": 19068.6109394216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4318517631084, 361.3459638055119, 368.6240035164132, 377.3415390144199, 395.70519962627844, 15050.247487625616, 15396.69206615867, 16200.270987805532, 20940.0, 21302.57394852102, 15598.610034749108, 20003.0, 20618.0, 20907.895460522675, 21263.893680531615, 5067.391912970439, 6077.513798896078, 6086.117512960618, 6106.572539922207, 6152.077188421727, 4825.710457372551, 6165.722542485577, 6197.256329240475, 6228.283747369065, 6239.469645080174, 5808.1578171165365, 6177.660228687443, 6181.690915454232, 6192.473639740628, 6196.81409557714, 6003.729832157564, 6152.907706384408, 6190.226221722285, 6194.876102477971, 6208.813735587917, 4642.442906851199, 5699.031164702011, 5958.910616340759, 6007.309159446676, 6014.338422773491, 10785.298955567863, 12920.676983075404, 12973.027022973314, 13202.801957970638, 13216.008799339992, 2101.6112019276484, 2215.313252891609, 2258.9495884413664, 2401.183597576815, 2694.488047271032, 9755.365901216399, 9849.21206303494, 9851.704448866545, 10377.740556486073, 10387.169026477864, 1812.746215529827, 1866.2908094923978, 1892.990535047316, 1907.551725344543, 1914.5405102775233, 90644.09355906422, 117301.0, 123859.0, 125992.0, 128918.99999999907, 11199.10407167441, 11399.259048161843, 11453.083753299716, 11518.251313664585, 11678.299302041905, 14346.928265358607, 14375.424983000563, 14388.208648524222, 14390.136591804525, 14394.280285985658, 8491.108433614381, 8603.612837422332, 8641.222289993932, 8650.91349086501, 8761.737147885573, 8676.913230867736, 8685.652573896974, 8692.217700406994, 8801.295896328278, 8823.823523529622, 4447.844325448594, 4456.420665313489, 4470.977645111753, 4504.909901801946, 4574.839880604163, 1846.9076546172637, 1881.8870867747705, 1882.981170188308, 1912.5218695326168, 1919.4145785535545, 818.4802650316973, 874.3660845886808, 904.7240591619619, 912.8721978922956, 958.3674774648838, 20629.0, 21898.01458934352, 21902.342929711816, 22031.66952495714, 22037.559248814934, 797.6729540888208, 880.8106257154742, 899.545773916133, 906.3836591118103, 998.3510718033336, 10599.311044782064, 11439.88560114405, 11552.075833933266, 11567.248128871764, 11588.420578971018, 530267.0, 549899.0, 556891.0, 570138.0, 570498.0, 124615.0, 125477.49045019048, 129964.0, 130421.0, 130887.34556327158, 890.7773056735816, 898.2454738020094, 920.963161473547, 923.9630414783468, 924.7919218175991, 15659.765103523228, 18797.06014699287, 19289.324873629357, 19520.707189392455, 19543.60912781765, 42307.576924231595, 52804.47195528149, 54392.0, 55045.44954550403, 55691.0, 76638.08404789925, 76763.61618191874, 78545.0, 79287.60356198181, 79726.0, 7165.928340716526, 7530.472866899484, 7902.0912595052305, 8157.592120394075, 8175.1416101308505, 10435.791284174122, 12754.979601632032, 12830.935845320713, 13064.0, 13172.934135329262, 9054.547272636473, 9951.701448956543, 10346.586136554453, 11175.944120279346, 11464.656060318204, 10541.57833686644, 10555.894441055798, 10783.946080269548, 10945.890541094486, 11114.49984750672, 9130.634774609207, 10296.661434013531, 10709.303895246783, 10786.406747628957, 11141.72145696364, 7662.195469475625, 7844.137144914169, 7968.681252750057, 8034.879476807736, 8063.475874068166, 7487.6630551626395, 8872.64509419616, 9526.333156678966, 10546.0, 10855.511501982272], "value": 9224.497804848123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.5754843353259, 1363.6795353092027, 1504.285464404408, 1625.9918700406497, 1855.7587513623218, 7773.6501857416415, 8251.793705157366, 8631.438956467833, 8860.734177974655, 8888.555572221396, 8750.299976001921, 8839.0, 8842.292616590674, 8844.38089333747, 8891.0, 2382.4996750682376, 2410.240774156144, 2411.2284069097896, 2411.577973854577, 2413.879306034691, 2364.47981444082, 2394.8922298496523, 2400.8919598618018, 2404.338806828119, 2405.915792947247, 2373.0507796881298, 2387.0, 2389.6296074108454, 2402.435427674504, 2406.4826062396583, 2341.1220792202926, 2358.2335740884196, 2359.9410014749596, 2371.1937941100023, 2379.5240951809706, 2329.219711396684, 2355.305184970438, 2360.280114565057, 2360.586897292967, 2361.858288502678, 8769.693060742908, 8771.298296136294, 8851.734447966572, 8852.778680533038, 8861.468311901242, 5147.639665223436, 5355.866103347408, 5383.703896285702, 5384.569234461273, 5397.946020539823, 3368.4105281575626, 3520.4543295789194, 3563.073600863768, 3597.388443964532, 3600.243948770735, 1019.6176433837311, 1046.633678212627, 1048.6749107776614, 1070.9410982395966, 1072.1369297715414, 11519.884801151966, 11550.422478876106, 11597.072234221241, 11622.651320460314, 11630.953214210762, 3845.0, 4487.506374298824, 4542.250528662799, 4647.02501436888, 4656.068786242698, 8915.331350148765, 9016.819663606691, 9067.773305667411, 9073.54632268384, 9079.546022698838, 5207.0887594670785, 5207.401148867929, 5214.739263036909, 5216.686998780086, 5222.112240919053, 4327.221100201994, 4371.453568303962, 4531.728096314232, 4535.909281814345, 4892.119418504703, 3759.342115129841, 3779.1874746928993, 3844.0774214188395, 3848.191879705237, 3862.0537968197973, 994.9054839790208, 995.6714284286168, 1166.1545379599722, 1184.8400465936988, 1187.0562902492538, 633.5818359882547, 815.975520734379, 898.7258886039821, 909.2498688581815, 932.47315266874, 5692.345380281321, 5773.566982476331, 5871.1486834409625, 5957.4638282553915, 6026.186464827192, 937.3532262738688, 938.9201917837061, 939.6758118449125, 950.6720181537358, 997.0627610046533, 3664.2305115925956, 3739.383001804726, 3948.9605103949166, 3979.2439436507548, 3998.3802510610903, 10382.169426445866, 10606.57573697059, 10617.628383006559, 10780.676579702622, 10796.730081748019, 10613.893861061444, 10738.94630526858, 10741.83887241692, 10747.89252107469, 10774.78450430987, 7793.4154938378715, 8156.592170391456, 8333.208345207195, 8363.95818020906, 8369.079401265855, 4955.331030310862, 5847.561432892635, 6110.969445152924, 6191.566590338633, 6211.627302361872, 8748.47509149453, 9626.47054412014, 9759.707208783748, 10070.798584028425, 10085.344452610558, 9755.414675119515, 9780.41317520951, 9900.207983361457, 9904.603815847286, 10160.949195253976, 7947.44367894265, 8112.918870811216, 8233.876491852747, 8248.793780155544, 8335.291500222549, 8214.301784348398, 8271.131531189138, 8383.03595086573, 8395.538245396561, 8404.243618074403, 7454.329110380092, 7476.140243871807, 7525.36034437079, 7527.322540971339, 7547.886781698388, 7171.42628589722, 7191.676374563052, 7215.386692131017, 7236.638168091679, 7248.782536523912, 6910.170779506491, 6976.232614412512, 7046.647667616701, 7064.858702826017, 7092.290770923073, 4989.201727723546, 5017.347744793154, 5020.096382651158, 5043.0, 5045.9243111352625, 4801.447833499193, 4845.6608037438455, 4853.587445067209, 4952.232403977389, 4970.478099799614], "value": 4532.988745573089, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.44948451550465, 297.1871930270709, 300.9082229919875, 305.71263012768003, 311.5420332111795, 4967.435257893765, 5064.797408103676, 5128.871778205542, 5244.868878278045, 5250.579953603712, 4403.6477081833455, 5180.326557547513, 5185.403678576965, 5200.453952335007, 5202.52285904049, 3531.629178936213, 3939.8921576956263, 3997.98001009996, 4018.3369743992207, 4043.796131108553, 3792.222594368148, 3939.369700847865, 4019.0, 4026.6174713402324, 4043.6360727534516, 3838.7888666123354, 3865.362215234497, 3997.6002399759936, 4004.899877503057, 4022.4971878515184, 3304.4712845944773, 3402.9829850850833, 3975.284448799215, 3985.083430810915, 4019.135885784541, 3448.2069323951655, 3448.3448144852396, 3473.645278341449, 3486.7210623150086, 3502.176988407722, 4460.996275837943, 4829.9231330527855, 5000.349604946424, 5215.0, 5216.60875434344, 3894.6494815466463, 4541.250693635546, 4567.292069729164, 4595.770211489412, 4610.423697037871, 5101.438841727407, 5506.944930550723, 5525.408484485077, 5537.889242215173, 5573.832785016456, 3555.6977656899194, 3765.435184722286, 3789.696824254053, 3796.4115562087923, 3801.182745709658, 5748.511376533, 5785.971070144665, 5803.245578074865, 5808.431723434691, 5828.6502809831545, 3485.4074807282823, 3678.429843374281, 3887.8639247626197, 3889.649931506178, 3892.630200130983, 3133.9843300783805, 3582.902640033491, 3882.456456096149, 3914.432407300925, 3915.5105611798526, 3399.5070714746716, 4393.340998850134, 4404.273294906368, 4431.135928493913, 4604.240300350405, 5054.9274797333655, 5524.58565607573, 5530.198121272473, 5545.500904918576, 5553.194786755897, 1303.882650561435, 1320.586971940015, 1322.6957799706122, 1329.634350553586, 1331.8601546837442, 692.4495026453981, 747.3834086878347, 806.9233422824823, 813.4021494201756, 822.7696245051395, 3956.645795751523, 4301.591348821857, 4307.396964424983, 4346.6522678185665, 4350.543192964757, 4458.4426946631675, 4674.027076984604, 4687.156311863897, 4714.457837348748, 4729.6689231754135, 4099.446574712376, 4241.745495270232, 4250.553691862372, 4304.4834619845815, 4409.919569705443, 2069.927552535654, 2362.7164740231283, 2435.659007738918, 2488.8631125288284, 2500.437401584665, 3770.981145094257, 4725.4565724941385, 4843.757812109451, 4918.385201849769, 4920.162273426733, 4037.8208554146318, 4285.46431696038, 4353.804078816461, 4438.866833994985, 4833.782479788418, 4200.348945913388, 4537.727736335831, 4784.569388755029, 4819.638527110551, 4942.5304596063315, 4149.522804877357, 4430.313301438282, 4656.41794775653, 4691.343211950398, 4702.929456058094, 3647.7264205184188, 3848.5766565677195, 4454.933176002427, 4697.788599513098, 4714.996126646231, 4065.837366505307, 4464.196444639996, 4781.545753153445, 4831.806727730992, 4958.7024778513405, 2668.4129491511835, 3127.7185053345306, 3205.7435405168, 3289.4999800151577, 3296.604407471119, 4267.50923643785, 4282.8715138545895, 4657.883552911204, 4748.501407352178, 4766.046790641816, 4032.415299781574, 4866.880617457934, 5272.821103193689, 5389.137737961907, 5501.0, 4608.723476591415, 5012.899742005213, 5549.611527193219, 5554.666719996813, 5581.7767289309595, 5203.27154198405, 5410.431904649955, 5469.917951230815, 5505.697186654773, 5562.749676264497, 4436.489803672619, 5088.338515992898, 5608.971955140361, 5680.4662741058855, 5744.396838331915, 4621.376114224537, 4850.587700045536, 5526.50261476469, 5540.22436858832, 5547.972260138674], "value": 3758.119400111074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.6139793328138, 637.9585326953749, 677.7661706711186, 715.9391451726603, 716.1263258824235, 12900.935495322534, 13067.150635208705, 14101.153930764136, 14256.501022464203, 14322.641933951643, 12702.17435866668, 12932.28872412017, 12954.287514186715, 12957.870421295807, 13007.479700811957, 679.3274658088507, 828.2131974624101, 845.71245776436, 847.1359213602123, 851.4720873058712, 685.7736946807566, 694.0110342761544, 694.6665600511758, 696.7282759723712, 697.7557854750822, 867.8698195270697, 899.9965038981521, 901.2294488212582, 909.3725329522641, 911.7994041310934, 892.6161750447305, 895.1451363947415, 895.3598177303194, 898.5597057441806, 899.3749344205779, 524.9553787928031, 657.6120089147378, 658.6245839871275, 659.1233659233209, 660.5343233020709, 11746.765064698659, 13418.597442076752, 13946.302684865715, 13997.230152341617, 14206.360713767905, 12847.29339886306, 13094.869051309555, 13247.668808279774, 13305.40125694346, 13596.456141754317, 9316.720498385059, 10357.430341331225, 10573.524191411405, 10813.351198928089, 11092.223544351898, 3248.204189973448, 3259.788113772597, 3271.1985563536846, 3278.278778668689, 3300.8349582520777, 115166.0, 115710.42144789307, 115936.42031789871, 117783.93296402243, 119525.0, 9898.851517227247, 9974.152197063186, 10238.232132590085, 10306.690799276033, 10529.578816847394, 18971.0, 20131.0, 20183.596328073356, 20524.38426847197, 20525.794742052687, 6035.36628653985, 6952.409045231111, 7072.646367681596, 7194.136703595497, 7252.3835473984245, 3857.459955606161, 3971.2653159165648, 3984.143409167043, 4004.2391945530258, 4008.819603117867, 3198.440272952224, 3375.6118046424485, 3380.7295416366633, 3386.983065084659, 3391.745619078579, 600.741681077141, 604.652324913168, 609.4636719686736, 609.8414412252757, 616.8642898562309, 580.1558732044865, 599.2928344553382, 601.5247954116287, 612.1216054961145, 634.3497914637534, 7141.785746427616, 8669.783255418664, 8725.825483490295, 8729.65081396737, 8908.465492070496, 603.9560614502857, 629.0972454527767, 631.0439683878927, 631.6778442994106, 647.5661306924372, 3604.387254166798, 4043.1509383029893, 4341.544137865479, 4385.502896836815, 4391.5827996340295, 87566.12433875707, 154122.0, 158459.0, 165165.17417412836, 166249.16875415546, 84284.0, 88431.0, 89097.0, 141086.2945685265, 142331.0, 106247.4687626557, 111973.44013279882, 114618.42690786492, 115749.0, 120806.0, 8169.2647661710735, 8389.580520974048, 8407.411481196257, 8528.91471085306, 8590.0, 66147.0, 66147.6692616553, 67763.66118169378, 69242.0, 69412.0, 80984.38031239224, 91793.08206917845, 97090.0290997081, 101414.49292753488, 102732.0, 10703.625373111903, 12444.502219911103, 12622.431990560262, 12624.116311858083, 12894.0, 13665.385057672229, 13959.581212563638, 14722.63193420173, 14885.404583816526, 14893.627659308604, 11226.607068752555, 11400.543978240778, 11876.049916006526, 12203.511859525875, 12470.563530276397, 11146.331220126818, 11275.0, 13101.148425352703, 13929.512467063603, 14022.0, 12807.527134379294, 12926.935365323114, 13122.868771312547, 13145.60563183106, 14084.859151408764, 10711.730333505597, 11060.889391105986, 11388.772224555629, 11528.941167152037, 11983.520659173535, 11362.602308919148, 11521.251118677259, 11590.0, 11672.299662020307, 11775.175737698279], "value": 7369.073743464221, "unit": "score"}], "name": "dromaeo_css", "value": 7078.729568153251, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 116.0, 116.0, 114.0, 115.0, 114.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 109.0, 109.0, 141.0, 107.0, 113.0, 137.0, 138.0, 139.0, 106.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 182.0, 182.0, 185.0, 184.0, 184.0, 186.0, 185.0, 179.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 61.0, 59.0, 59.0, 61.0, 84.0, 69.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 94.0, 72.0, 68.0, 70.0, 92.0, 67.0, 68.0, 90.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 90.0, 85.0, 90.0, 86.0, 88.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 104.0, 133.0, 136.0, 83.0, 83.0, 83.0, 83.0, 85.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 52.0, 55.0, 55.0, 58.0, 58.0, 58.0, 58.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 71.0, 79.0, 70.0, 69.0, 69.0, 74.0, 100.0, 86.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 82.0, 81.0, 82.0, 80.0, 82.0, 83.0, 87.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 119.0, 145.0, 143.0, 157.0, 154.0, 136.0, 169.0, 139.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 159.0, 160.0, 164.0, 163.0, 160.0, 162.0, 164.0, 205.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 66.0, 68.0, 80.0, 86.0, 86.0, 86.0, 65.0, 66.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1447.8000000000002, "alertThreshold": 2.0}]} 09:04:25 INFO - Return code: 0 09:04:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:25 INFO - # TBPL SUCCESS # 09:04:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:04:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:04:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:04:25 INFO - 2016-10-20 09:04:25.975 screenresolution[1672:10316] starting screenresolution argv=screenresolution get 09:04:25 INFO - 2016-10-20 09:04:25.978 screenresolution[1672:10316] Display 0: 1600x1200x32@60 09:04:25 INFO - 2016-10-20 09:04:25.984 screenresolution[1673:10319] starting screenresolution argv=screenresolution list 09:04:25 INFO - Available Modes on Display 0 09:04:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:04:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:04:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:04:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:04:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:04:26 INFO - Intel Iris: 09:04:26 INFO - Chipset Model: Intel Iris 09:04:26 INFO - Type: GPU 09:04:26 INFO - Bus: Built-In 09:04:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:04:26 INFO - Vendor: Intel (0x8086) 09:04:26 INFO - Device ID: 0x0a2e 09:04:26 INFO - Revision ID: 0x0009 09:04:26 INFO - Displays: 09:04:26 INFO - Display: 09:04:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:04:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:04:26 INFO - Display Serial Number: 1600x1200 60 09:04:26 INFO - Main Display: Yes 09:04:26 INFO - Mirror: Off 09:04:26 INFO - Online: Yes 09:04:26 INFO - Rotation: Supported 09:04:26 INFO - Return code: 0 09:04:26 INFO - Running post-action listener: _resource_record_post_action 09:04:26 INFO - [mozharness: 2016-10-20 16:04:26.219120Z] Finished run-tests step (success) 09:04:26 INFO - Running post-run listener: _resource_record_post_run 09:04:26 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38577152; Write bytes: 662777856; Read time: 377; Write time: 1890 09:04:26 INFO - TinderboxPrint: CPU usage
53.6% 09:04:26 INFO - TinderboxPrint: I/O read bytes / time
38,577,152 / 377 09:04:26 INFO - TinderboxPrint: I/O write bytes / time
662,777,856 / 1,890 09:04:26 INFO - TinderboxPrint: CPU idle
2,247.1 (46.4%) 09:04:26 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 09:04:26 INFO - TinderboxPrint: CPU user
1,621.7 (33.5%) 09:04:26 INFO - TinderboxPrint: Swap in / out
401,862,656 / 0 09:04:26 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356561408; Write bytes: 355346432; Read time: 27572; Write time: 664 09:04:26 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37598208; Write bytes: 297244672; Read time: 362; Write time: 1190 09:04:26 INFO - Running post-run listener: _upload_blobber_files 09:04:26 INFO - Blob upload gear active. 09:04:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:26 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 09:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:27 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:04:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:28 INFO - (blobuploader) - INFO - Done attempting. 09:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:29 INFO - (blobuploader) - INFO - Done attempting. 09:04:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:31 INFO - (blobuploader) - INFO - Done attempting. 09:04:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:31 INFO - Return code: 0 09:04:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99039028fd93f1596389d7d3553cfc506812c73216c6da2d8693f338da1214bd2ebc2191c4fe7d13a7513ae5095ab10add7c7ad6ad733104b29e0ac338dc024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9325e634ef2fa36ed6bc4385e1d5bfe49d90af713e204c5d66b458c64fa1b63430079788f2b32e2f78b7d959df3c97e7ef4a7fe488b4f9b2fb02e537c790684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f8afb0597ef304f2a6351a17b00f77f101767a109188e213c5c67e06c6f56a01855f687c36c27d4022aaef2ea7dc4008ec76d915382e8f04965d1dd1731572"} 09:04:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:31 INFO - Contents: 09:04:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99039028fd93f1596389d7d3553cfc506812c73216c6da2d8693f338da1214bd2ebc2191c4fe7d13a7513ae5095ab10add7c7ad6ad733104b29e0ac338dc024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9325e634ef2fa36ed6bc4385e1d5bfe49d90af713e204c5d66b458c64fa1b63430079788f2b32e2f78b7d959df3c97e7ef4a7fe488b4f9b2fb02e537c790684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f8afb0597ef304f2a6351a17b00f77f101767a109188e213c5c67e06c6f56a01855f687c36c27d4022aaef2ea7dc4008ec76d915382e8f04965d1dd1731572"} 09:04:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:31 INFO - Copying logs to upload dir... 09:04:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.272809 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-20 09:04:31.990870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:04:31.998363) ========= 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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99039028fd93f1596389d7d3553cfc506812c73216c6da2d8693f338da1214bd2ebc2191c4fe7d13a7513ae5095ab10add7c7ad6ad733104b29e0ac338dc024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9325e634ef2fa36ed6bc4385e1d5bfe49d90af713e204c5d66b458c64fa1b63430079788f2b32e2f78b7d959df3c97e7ef4a7fe488b4f9b2fb02e537c790684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f8afb0597ef304f2a6351a17b00f77f101767a109188e213c5c67e06c6f56a01855f687c36c27d4022aaef2ea7dc4008ec76d915382e8f04965d1dd1731572"} build_url:https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011083 build_url: 'https://queue.taskcluster.net/v1/task/dESXVnprRtOmuLEbl3IK6A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f99039028fd93f1596389d7d3553cfc506812c73216c6da2d8693f338da1214bd2ebc2191c4fe7d13a7513ae5095ab10add7c7ad6ad733104b29e0ac338dc024", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9325e634ef2fa36ed6bc4385e1d5bfe49d90af713e204c5d66b458c64fa1b63430079788f2b32e2f78b7d959df3c97e7ef4a7fe488b4f9b2fb02e537c790684", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f8afb0597ef304f2a6351a17b00f77f101767a109188e213c5c67e06c6f56a01855f687c36c27d4022aaef2ea7dc4008ec76d915382e8f04965d1dd1731572"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:04:32.034130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:04:32.034474) ========= 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.38BnZEYxiH/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.qnsMp3SEHJ/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:04:32.082838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:04:32.083868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:04:32.084192) ========= ========= Total master_lag: 3.71 =========