builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0292 starttime: 1475970197.25 results: success (0) buildid: 20161008142616 builduid: 8e405d15409f437fbf45f00049e5e947 revision: 443a41b1b8f62de2866b162d09a545371abed2ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:17.249080) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:17.249438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:17.249696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:17.274733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:17.275102) ========= 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.3hZZoKktTM/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.Wmamrb2UdT/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-08 16:43:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2016-10-08 16:43:17 (21.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.596449 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:18.041506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:18.041778) ========= 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.3hZZoKktTM/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.Wmamrb2UdT/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.027174 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:18.111030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-08 16:43:18.111323) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 443a41b1b8f62de2866b162d09a545371abed2ba --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 443a41b1b8f62de2866b162d09a545371abed2ba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hZZoKktTM/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.Wmamrb2UdT/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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-08 16:43:18,189 truncating revision to first 12 chars 2016-10-08 16:43:18,190 Setting DEBUG logging. 2016-10-08 16:43:18,190 attempt 1/10 2016-10-08 16:43:18,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/443a41b1b8f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 16:43:19,250 unpacking tar archive at: mozilla-aurora-443a41b1b8f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-08 16:43:19.487139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:19.487433) ========= script_repo_revision: 443a41b1b8f62de2866b162d09a545371abed2ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:19.487811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:19.488070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 16:43:19.504175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-08 16:43:19.504546) ========= /tools/buildbot/bin/python 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', '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:43:19 INFO - MultiFileLogger online at 20161008 16:43:19 in /builds/slave/test 16:43:19 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 16:43:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:43:19 INFO - {'append_to_log': False, 16:43:19 INFO - 'base_work_dir': '/builds/slave/test', 16:43:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:43:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:43:19 INFO - 'branch': 'Mozilla-Aurora', 16:43:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:19 INFO - 'config_files': ('talos/mac_config.py',), 16:43:19 INFO - 'default_actions': ('clobber', 16:43:19 INFO - 'read-buildbot-config', 16:43:19 INFO - 'download-and-extract', 16:43:19 INFO - 'populate-webroot', 16:43:19 INFO - 'create-virtualenv', 16:43:19 INFO - 'install', 16:43:19 INFO - 'run-tests'), 16:43:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:19 INFO - 'download_minidump_stackwalk': True, 16:43:19 INFO - 'download_symbols': 'ondemand', 16:43:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:43:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:43:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:43:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:43:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:19 INFO - 'installer_path': 'installer.exe', 16:43:19 INFO - 'log_level': 'info', 16:43:19 INFO - 'log_name': 'talos', 16:43:19 INFO - 'log_to_console': True, 16:43:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:43:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:43:19 INFO - 'opt_config_files': (), 16:43:19 INFO - 'pip_index': False, 16:43:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:43:19 INFO - 'cmd': ('bash', 16:43:19 INFO - '-c', 16:43:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:43:19 INFO - 'enabled': True, 16:43:19 INFO - 'halt_on_failure': False, 16:43:19 INFO - 'name': 'check_screen_resolution'},), 16:43:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:43:19 INFO - 'cmd': ('bash', 16:43:19 INFO - '-c', 16:43:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:43:19 INFO - 'enabled': True, 16:43:19 INFO - 'halt_on_failure': False, 16:43:19 INFO - 'name': 'check_screen_resolution'},), 16:43:19 INFO - 'run_cmd_checks_enabled': True, 16:43:19 INFO - 'sps_profile': False, 16:43:19 INFO - 'sps_profile_interval': 0, 16:43:19 INFO - 'suite': 'dromaeojs', 16:43:19 INFO - 'system_bits': '32', 16:43:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:19 INFO - 'title': 't-yosemite-r7-0292', 16:43:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:19 INFO - 'use_talos_json': True, 16:43:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:43:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:19 INFO - 'work_dir': 'build'} 16:43:19 INFO - [mozharness: 2016-10-08 23:43:19.688796Z] Running clobber step. 16:43:19 INFO - Running pre-action listener: _resource_record_pre_action 16:43:19 INFO - Running main action method: clobber 16:43:19 INFO - rmtree: /builds/slave/test/build 16:43:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:43:22 INFO - Running post-action listener: _resource_record_post_action 16:43:22 INFO - [mozharness: 2016-10-08 23:43:22.053001Z] Finished clobber step (success) 16:43:22 INFO - [mozharness: 2016-10-08 23:43:22.053127Z] Running read-buildbot-config step. 16:43:22 INFO - Running pre-action listener: _resource_record_pre_action 16:43:22 INFO - Running main action method: read_buildbot_config 16:43:22 INFO - Using buildbot properties: 16:43:22 INFO - { 16:43:22 INFO - "project": "", 16:43:22 INFO - "product": "firefox", 16:43:22 INFO - "script_repo_revision": "production", 16:43:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:43:22 INFO - "repository": "", 16:43:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:43:22 INFO - "buildid": "20161008142616", 16:43:22 INFO - "pgo_build": "False", 16:43:22 INFO - "basedir": "/builds/slave/test", 16:43:22 INFO - "buildnumber": 41, 16:43:22 INFO - "slavename": "t-yosemite-r7-0292", 16:43:22 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:43:22 INFO - "platform": "yosemite_r7", 16:43:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:43:22 INFO - "branch": "mozilla-aurora", 16:43:22 INFO - "repo_path": "releases/mozilla-aurora", 16:43:22 INFO - "revision": "443a41b1b8f62de2866b162d09a545371abed2ba", 16:43:22 INFO - "stage_platform": "macosx64", 16:43:22 INFO - "builduid": "8e405d15409f437fbf45f00049e5e947", 16:43:22 INFO - "slavebuilddir": "test" 16:43:22 INFO - } 16:43:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:43:22 INFO - Running post-action listener: _resource_record_post_action 16:43:22 INFO - [mozharness: 2016-10-08 23:43:22.056400Z] Finished read-buildbot-config step (success) 16:43:22 INFO - [mozharness: 2016-10-08 23:43:22.056532Z] Running download-and-extract step. 16:43:22 INFO - Running pre-action listener: _resource_record_pre_action 16:43:22 INFO - Running main action method: download_and_extract 16:43:22 INFO - mkdir: /builds/slave/test/build/tests 16: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')]} 16:43:22 INFO - trying https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:43:22 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/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 16:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/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 16:43:23 INFO - Downloaded 1199 bytes. 16:43:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:43:23 INFO - Using the following test package requirements: 16:43:23 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:43:23 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:43:23 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:43:23 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'jsshell-mac.zip'], 16:43:23 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:43:23 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:43:23 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:43:23 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:43:23 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:43:23 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:43:23 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:43:23 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:43:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:43:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:43:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:43:23 INFO - Expected file size: 16434720 16:43:30 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 16:43:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:43:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:43:30 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:43:31 INFO - Expected file size: 16434720 16:43:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:43:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:43:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:43:38 INFO - Expected file size: 14414059 16:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:38 INFO - trying https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:43:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/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 16:43:41 INFO - Downloaded 115376699 bytes. 16:43:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:43:41 INFO - mkdir: /builds/slave/test/properties 16:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:41 INFO - Contents: 16:43:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:43:42 INFO - Running post-action listener: _resource_record_post_action 16:43:42 INFO - Running post-action listener: set_extra_try_arguments 16:43:42 INFO - [mozharness: 2016-10-08 23:43:42.801592Z] Finished download-and-extract step (success) 16:43:42 INFO - [mozharness: 2016-10-08 23:43:42.801705Z] Running populate-webroot step. 16:43:42 INFO - Running pre-action listener: _resource_record_pre_action 16:43:42 INFO - Running main action method: populate_webroot 16:43:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:42 INFO - '--tppagecycles', 16:43:42 INFO - '7'], 16:43:42 INFO - 'tests': ['tsvgm']}}, 16:43:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['damp', 'tps']}, 16:43:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'tests': ['damp', 'tps']}, 16:43:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['dromaeo_dom']}, 16:43:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['basic_compositor_video']}, 16:43:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:43:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['a11yr', 16:43:42 INFO - 'ts_paint', 16:43:42 INFO - 'tpaint', 16:43:42 INFO - 'sessionrestore', 16:43:42 INFO - 'sessionrestore_no_auto_restore', 16:43:42 INFO - 'tabpaint']}, 16:43:42 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:42 INFO - 'ts_paint', 16:43:42 INFO - 'tpaint', 16:43:42 INFO - 'sessionrestore', 16:43:42 INFO - 'sessionrestore_no_auto_restore', 16:43:42 INFO - 'tabpaint']}, 16:43:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:43:42 INFO - 'ts_paint', 16:43:42 INFO - 'tpaint', 16:43:42 INFO - 'sessionrestore', 16:43:42 INFO - 'sessionrestore_no_auto_restore', 16:43:42 INFO - 'tabpaint']}, 16:43:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:43:42 INFO - 'ts_paint', 16:43:42 INFO - 'tpaint', 16:43:42 INFO - 'sessionrestore', 16:43:42 INFO - 'sessionrestore_no_auto_restore', 16:43:42 INFO - 'tabpaint']}, 16:43:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['a11yr', 16:43:42 INFO - 'ts_paint', 16:43:42 INFO - 'tpaint', 16:43:42 INFO - 'sessionrestore', 16:43:42 INFO - 'sessionrestore_no_auto_restore', 16:43:42 INFO - 'tabpaint']}, 16:43:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['a11yr', 16:43:42 INFO - 'ts_paint', 16:43:42 INFO - 'tpaint', 16:43:42 INFO - 'sessionrestore', 16:43:42 INFO - 'sessionrestore_no_auto_restore', 16:43:42 INFO - 'tabpaint']}, 16:43:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['tsvgx', 16:43:42 INFO - 'tsvgr_opacity', 16:43:42 INFO - 'tart', 16:43:42 INFO - 'tscrollx', 16:43:42 INFO - 'cart']}, 16:43:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:42 INFO - 'tsvgr_opacity', 16:43:42 INFO - 'tart', 16:43:42 INFO - 'tscrollx', 16:43:42 INFO - 'cart']}, 16:43:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'talos_options': ['--disable-e10s'], 16:43:42 INFO - 'tests': ['tp5o']}, 16:43:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'tests': ['tp5o']}, 16:43:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'talos_options': ['--disable-e10s', 16:43:42 INFO - '--xperf_path', 16:43:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:42 INFO - 'tests': ['tp5n']}, 16:43:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:42 INFO - 'talos_options': ['--xperf_path', 16:43:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:42 INFO - 'tests': ['tp5n']}}, 16:43:42 INFO - 'talos.zip': {'path': '', 16:43:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:42 INFO - Running post-action listener: _resource_record_post_action 16:43:42 INFO - [mozharness: 2016-10-08 23:43:42.819972Z] Finished populate-webroot step (success) 16:43:42 INFO - [mozharness: 2016-10-08 23:43:42.820083Z] Running create-virtualenv step. 16:43:42 INFO - Running pre-action listener: _resource_record_pre_action 16:43:42 INFO - Running main action method: create_virtualenv 16:43:42 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:42 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 16:43:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:42 INFO - Using real prefix '/tools/python27' 16:43:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:43 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:46 INFO - Installing pip.................done. 16:43:46 INFO - Return code: 0 16:43:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:46 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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:43:46 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 16:43:46 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 16:43:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:43:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:46 INFO - 'HOME': '/Users/cltbld', 16:43:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:46 INFO - 'LOGNAME': 'cltbld', 16:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:46 INFO - 'MOZ_NO_REMOTE': '1', 16:43:46 INFO - 'NO_EM_RESTART': '1', 16:43:46 INFO - 'PAGER': '/bin/cat', 16:43:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:46 INFO - 'PWD': '/builds/slave/test', 16:43:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:46 INFO - 'SHELL': '/bin/bash', 16:43:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:43:46 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:43:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:46 INFO - 'USER': 'cltbld', 16:43:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:46 INFO - 'XPC_FLAGS': '0x0', 16:43:46 INFO - 'XPC_SERVICE_NAME': '0', 16:43:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:46 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 16:43:46 INFO - Cleaning up... 16:43:46 INFO - Return code: 0 16:43:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:46 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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:43:46 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 16:43:46 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 16:43:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:43:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:46 INFO - 'HOME': '/Users/cltbld', 16:43:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:46 INFO - 'LOGNAME': 'cltbld', 16:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:46 INFO - 'MOZ_NO_REMOTE': '1', 16:43:46 INFO - 'NO_EM_RESTART': '1', 16:43:46 INFO - 'PAGER': '/bin/cat', 16:43:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:46 INFO - 'PWD': '/builds/slave/test', 16:43:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:46 INFO - 'SHELL': '/bin/bash', 16:43:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:43:46 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:43:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:46 INFO - 'USER': 'cltbld', 16:43:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:46 INFO - 'XPC_FLAGS': '0x0', 16:43:46 INFO - 'XPC_SERVICE_NAME': '0', 16:43:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:47 INFO - Downloading/unpacking psutil>=3.1.1 16:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:50 INFO - Installing collected packages: psutil 16:43:50 INFO - Running setup.py install for psutil 16:43:50 INFO - building 'psutil._psutil_osx' extension 16:43:50 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 16: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:43:51 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 16:43:51 INFO - building 'psutil._psutil_posix' extension 16:43:51 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 16:43:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:43:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:43:51 INFO - ^ 16:43:51 INFO - 1 warning generated. 16:43:51 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 16:43:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:51 INFO - Successfully installed psutil 16:43:51 INFO - Cleaning up... 16:43:52 INFO - Return code: 0 16:43:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16: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 16: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 16:43:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:43:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:52 INFO - 'HOME': '/Users/cltbld', 16:43:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:52 INFO - 'LOGNAME': 'cltbld', 16:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:52 INFO - 'MOZ_NO_REMOTE': '1', 16:43:52 INFO - 'NO_EM_RESTART': '1', 16:43:52 INFO - 'PAGER': '/bin/cat', 16:43:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:52 INFO - 'PWD': '/builds/slave/test', 16:43:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:52 INFO - 'SHELL': '/bin/bash', 16:43:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:43:52 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:43:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:52 INFO - 'USER': 'cltbld', 16:43:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:52 INFO - 'XPC_FLAGS': '0x0', 16:43:52 INFO - 'XPC_SERVICE_NAME': '0', 16:43:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 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 16:43:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:43:54 INFO - Installing collected packages: mozsystemmonitor 16:43:54 INFO - Running setup.py install for mozsystemmonitor 16:43:55 INFO - Successfully installed mozsystemmonitor 16:43:55 INFO - Cleaning up... 16:43:55 INFO - Return code: 0 16:43:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16: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 16: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 16:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:55 INFO - 'HOME': '/Users/cltbld', 16:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:55 INFO - 'LOGNAME': 'cltbld', 16:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:55 INFO - 'MOZ_NO_REMOTE': '1', 16:43:55 INFO - 'NO_EM_RESTART': '1', 16:43:55 INFO - 'PAGER': '/bin/cat', 16:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:55 INFO - 'PWD': '/builds/slave/test', 16:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:55 INFO - 'SHELL': '/bin/bash', 16:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:43:55 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:55 INFO - 'USER': 'cltbld', 16:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:55 INFO - 'XPC_FLAGS': '0x0', 16:43:55 INFO - 'XPC_SERVICE_NAME': '0', 16:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:55 INFO - Downloading/unpacking jsonschema==2.5.1 16:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:43:57 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 16:43:57 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 16:43:57 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 16:43:57 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 16:43:57 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 16:43:57 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 16:43:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:58 INFO - warning: no files found matching '*.txt' 16:43:58 INFO - no previously-included directories found matching 'build' 16:43:58 INFO - no previously-included directories found matching 'dist' 16:43:58 INFO - no previously-included directories found matching '.git*' 16:43:58 INFO - Installing collected packages: jsonschema, functools32 16:43:58 INFO - Running setup.py install for functools32 16:43:58 INFO - warning: no files found matching '*.txt' 16:43:58 INFO - no previously-included directories found matching 'build' 16:43:58 INFO - no previously-included directories found matching 'dist' 16:43:58 INFO - no previously-included directories found matching '.git*' 16:43:58 INFO - Successfully installed jsonschema functools32 16:43:58 INFO - Cleaning up... 16:43:58 INFO - Return code: 0 16:43:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:58 INFO - 'HOME': '/Users/cltbld', 16:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:58 INFO - 'LOGNAME': 'cltbld', 16:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:58 INFO - 'MOZ_NO_REMOTE': '1', 16:43:58 INFO - 'NO_EM_RESTART': '1', 16:43:58 INFO - 'PAGER': '/bin/cat', 16:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:58 INFO - 'PWD': '/builds/slave/test', 16:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:58 INFO - 'SHELL': '/bin/bash', 16:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:43:58 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:58 INFO - 'USER': 'cltbld', 16:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:58 INFO - 'XPC_FLAGS': '0x0', 16:43:58 INFO - 'XPC_SERVICE_NAME': '0', 16:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:43:58 INFO - Cleaning up... 16:43:58 INFO - Return code: 0 16:43:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:58 INFO - 'HOME': '/Users/cltbld', 16:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:58 INFO - 'LOGNAME': 'cltbld', 16:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:58 INFO - 'MOZ_NO_REMOTE': '1', 16:43:58 INFO - 'NO_EM_RESTART': '1', 16:43:58 INFO - 'PAGER': '/bin/cat', 16:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:58 INFO - 'PWD': '/builds/slave/test', 16:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:58 INFO - 'SHELL': '/bin/bash', 16:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:43:58 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:58 INFO - 'USER': 'cltbld', 16:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:58 INFO - 'XPC_FLAGS': '0x0', 16:43:58 INFO - 'XPC_SERVICE_NAME': '0', 16:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:43:59 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 16:43:59 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 16:43:59 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 16:43:59 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 16:43:59 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 16:43:59 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 16:44:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:01 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 16:44:01 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 16:44:01 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 16:44:01 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 16:44:01 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 16:44:01 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 16:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16: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 16: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 16: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 16: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 16: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 16: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 16:44:02 INFO - Downloading docopt-0.6.1.tar.gz 16:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:03 INFO - Running setup.py install for blobuploader 16:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:03 INFO - Running setup.py install for requests 16:44:03 INFO - Running setup.py install for docopt 16:44:03 INFO - Successfully installed blobuploader requests docopt 16:44:03 INFO - Cleaning up... 16:44:03 INFO - Return code: 0 16:44:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:03 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')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 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')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:44:03 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 16:44:03 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 16:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:03 INFO - 'HOME': '/Users/cltbld', 16:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PAGER': '/bin/cat', 16:44:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test', 16:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:44:03 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - 'XPC_FLAGS': '0x0', 16:44:03 INFO - 'XPC_SERVICE_NAME': '0', 16:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-IWFSpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ty1VAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ZBgHOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Y8z1fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-goyEeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-0nvhIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Klu2th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-O8beRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:04 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Wpp9Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-JW7OA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-DjhTMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-zJVaE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-xAWQgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-iT8GSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-JkjxOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-y_KfEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:05 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-8RTtzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:05 INFO - Running setup.py install for manifestparser 16:44:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:06 INFO - Running setup.py install for mozcrash 16:44:06 INFO - Running setup.py install for mozdebug 16:44:06 INFO - Running setup.py install for mozdevice 16:44:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:06 INFO - Running setup.py install for mozfile 16:44:06 INFO - Running setup.py install for mozhttpd 16:44:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:06 INFO - Running setup.py install for mozinfo 16:44:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:06 INFO - Running setup.py install for mozInstall 16:44:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Running setup.py install for mozleak 16:44:07 INFO - Running setup.py install for mozlog 16:44:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Running setup.py install for moznetwork 16:44:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Running setup.py install for mozprocess 16:44:07 INFO - Running setup.py install for mozprofile 16:44:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:07 INFO - Running setup.py install for mozrunner 16:44:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:08 INFO - Running setup.py install for mozscreenshot 16:44:08 INFO - Running setup.py install for moztest 16:44:08 INFO - Running setup.py install for mozversion 16:44:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:08 INFO - Cleaning up... 16:44:08 INFO - Return code: 0 16:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:08 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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:44:08 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 16:44:08 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 16:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:08 INFO - 'HOME': '/Users/cltbld', 16:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:08 INFO - 'LOGNAME': 'cltbld', 16:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:08 INFO - 'MOZ_NO_REMOTE': '1', 16:44:08 INFO - 'NO_EM_RESTART': '1', 16:44:08 INFO - 'PAGER': '/bin/cat', 16:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:08 INFO - 'PWD': '/builds/slave/test', 16:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:08 INFO - 'SHELL': '/bin/bash', 16:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:44:08 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:08 INFO - 'USER': 'cltbld', 16:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:08 INFO - 'XPC_FLAGS': '0x0', 16:44:08 INFO - 'XPC_SERVICE_NAME': '0', 16:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-D8Xx3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:08 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)) 16:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-xC45Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:08 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)) 16:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-QVhiJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-wl13x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-leTIBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Z4MVHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-TmaVoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-07qvhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-avB1s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-BJZUuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-6OyfZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:09 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)) 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-YiYuAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:10 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)) 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ZNGXUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:10 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)) 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-jiSmAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:10 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)) 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-E1MyJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:10 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)) 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-CDJAzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:10 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)) 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:10 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-A3ydec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:10 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)) 16:44:10 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)) 16:44:10 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)) 16:44:10 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)) 16:44:10 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)) 16:44:10 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)) 16:44:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 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 16:44:10 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 16:44:13 INFO - Downloading blessings-1.6.tar.gz 16:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:13 INFO - Installing collected packages: blessings 16:44:13 INFO - Running setup.py install for blessings 16:44:13 INFO - Successfully installed blessings 16:44:13 INFO - Cleaning up... 16:44:13 INFO - Return code: 0 16:44:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:13 INFO - Reading from file tmpfile_stdout 16:44:13 INFO - Current package versions: 16:44:13 INFO - blessings == 1.6 16:44:13 INFO - blobuploader == 1.2.4 16:44:13 INFO - docopt == 0.6.1 16:44:13 INFO - functools32 == 3.2.3-2 16:44:13 INFO - jsonschema == 2.5.1 16:44:13 INFO - manifestparser == 1.1 16:44:13 INFO - mozInstall == 1.12 16:44:13 INFO - mozcrash == 0.17 16:44:13 INFO - mozdebug == 0.1 16:44:13 INFO - mozdevice == 0.48 16:44:13 INFO - mozfile == 1.2 16:44:13 INFO - mozhttpd == 0.7 16:44:13 INFO - mozinfo == 0.9 16:44:13 INFO - mozleak == 0.1 16:44:13 INFO - mozlog == 3.4 16:44:13 INFO - moznetwork == 0.27 16:44:13 INFO - mozprocess == 0.23 16:44:13 INFO - mozprofile == 0.28 16:44:13 INFO - mozrunner == 6.12 16:44:13 INFO - mozscreenshot == 0.1 16:44:13 INFO - mozsystemmonitor == 0.3 16:44:13 INFO - moztest == 0.7 16:44:13 INFO - mozversion == 1.4 16:44:13 INFO - psutil == 3.1.1 16:44:13 INFO - requests == 1.2.3 16:44:13 INFO - wsgiref == 0.1.2 16:44:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:13 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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:44:13 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 16:44:13 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 16:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:13 INFO - 'HOME': '/Users/cltbld', 16:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:13 INFO - 'LOGNAME': 'cltbld', 16:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:13 INFO - 'MOZ_NO_REMOTE': '1', 16:44:13 INFO - 'NO_EM_RESTART': '1', 16:44:13 INFO - 'PAGER': '/bin/cat', 16:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:13 INFO - 'PWD': '/builds/slave/test', 16:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:13 INFO - 'SHELL': '/bin/bash', 16:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:44:13 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:13 INFO - 'USER': 'cltbld', 16:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:13 INFO - 'XPC_FLAGS': '0x0', 16:44:13 INFO - 'XPC_SERVICE_NAME': '0', 16:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 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)) 16:44:13 INFO - Cleaning up... 16:44:14 INFO - Return code: 0 16:44:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:14 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')]} 16:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:14 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')]} 16:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:14 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 0x101517490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5315a3aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, '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.3hZZoKktTM/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.Wmamrb2UdT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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 16:44:14 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 16:44:14 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 16:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:14 INFO - 'HOME': '/Users/cltbld', 16:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:14 INFO - 'LOGNAME': 'cltbld', 16:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:14 INFO - 'MOZ_NO_REMOTE': '1', 16:44:14 INFO - 'NO_EM_RESTART': '1', 16:44:14 INFO - 'PAGER': '/bin/cat', 16:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:14 INFO - 'PWD': '/builds/slave/test', 16:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:14 INFO - 'SHELL': '/bin/bash', 16:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:44:14 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:14 INFO - 'USER': 'cltbld', 16:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:14 INFO - 'XPC_FLAGS': '0x0', 16:44:14 INFO - 'XPC_SERVICE_NAME': '0', 16:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:14 INFO - Cleaning up... 16:44:14 INFO - Return code: 0 16:44:14 INFO - Running post-action listener: _resource_record_post_action 16:44:14 INFO - Running post-action listener: _start_resource_monitoring 16:44:14 INFO - Starting resource monitoring. 16:44:14 INFO - [mozharness: 2016-10-08 23:44:14.301840Z] Finished create-virtualenv step (success) 16:44:14 INFO - [mozharness: 2016-10-08 23:44:14.302901Z] Running install step. 16:44:14 INFO - Running pre-action listener: _resource_record_pre_action 16:44:14 INFO - Running main action method: install 16:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:14 INFO - Reading from file tmpfile_stdout 16:44:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:14 INFO - Reading from file tmpfile_stdout 16:44:14 INFO - Output received: 16:44:14 INFO - Usage: mozinstall [options] installer 16:44:14 INFO - Options: 16:44:14 INFO - -h, --help show this help message and exit 16:44:14 INFO - -d DEST, --destination=DEST 16:44:14 INFO - Directory to install application into. [default: 16:44:14 INFO - "/builds/slave/test"] 16:44:14 INFO - --app=APP Application being installed. [default: firefox] 16:44:14 INFO - mkdir: /builds/slave/test/build/application 16:44:14 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'] 16:44:14 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 16:44:46 INFO - Reading from file tmpfile_stdout 16:44:46 INFO - Output received: 16:44:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:44:46 INFO - Running post-action listener: _resource_record_post_action 16:44:46 INFO - [mozharness: 2016-10-08 23:44:46.875635Z] Finished install step (success) 16:44:46 INFO - [mozharness: 2016-10-08 23:44:46.875791Z] Running run-tests step. 16:44:46 INFO - Running pre-action listener: _resource_record_pre_action 16:44:46 INFO - Running main action method: run_tests 16:44:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:44:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:44:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:44:46 INFO - 2016-10-08 16:44:46.890 screenresolution[1651:8700] starting screenresolution argv=screenresolution get 16:44:46 INFO - 2016-10-08 16:44:46.893 screenresolution[1651:8700] Display 0: 1600x1200x32@60 16:44:46 INFO - 2016-10-08 16:44:46.899 screenresolution[1652:8702] starting screenresolution argv=screenresolution list 16:44:46 INFO - Available Modes on Display 0 16:44:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:44:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:44:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:44:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:44:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:44:47 INFO - Intel Iris: 16:44:47 INFO - Chipset Model: Intel Iris 16:44:47 INFO - Type: GPU 16:44:47 INFO - Bus: Built-In 16:44:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:44:47 INFO - Vendor: Intel (0x8086) 16:44:47 INFO - Device ID: 0x0a2e 16:44:47 INFO - Revision ID: 0x0009 16:44:47 INFO - Displays: 16:44:47 INFO - Display: 16:44:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:44:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:44:47 INFO - Display Serial Number: 1600x1200 60 16:44:47 INFO - Main Display: Yes 16:44:47 INFO - Mirror: Off 16:44:47 INFO - Online: Yes 16:44:47 INFO - Rotation: Supported 16:44:47 INFO - Return code: 0 16:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:47 INFO - Python 2.7.3 16:44:47 INFO - Return code: 0 16:44:47 INFO - grabbing minidump binary from tooltool 16:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:47 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 0x10132bd30>, '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 0x101191db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101323b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:47 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 16:44:47 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 16:44:47 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 16:44:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:47 INFO - Return code: 0 16:44:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:44:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:44:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:47 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/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 16:44:47 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/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0292 --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 16:44:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hZZoKktTM/Render', 16:44:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:47 INFO - 'HOME': '/Users/cltbld', 16:44:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:47 INFO - 'LOGNAME': 'cltbld', 16:44:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:47 INFO - 'MOZ_NO_REMOTE': '1', 16:44:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:47 INFO - 'NO_EM_RESTART': '1', 16:44:47 INFO - 'PAGER': '/bin/cat', 16:44:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:47 INFO - 'PWD': '/builds/slave/test', 16:44:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:47 INFO - 'SHELL': '/bin/bash', 16:44:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wmamrb2UdT/Listeners', 16:44:47 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 16:44:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:47 INFO - 'USER': 'cltbld', 16:44:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:47 INFO - 'XPC_FLAGS': '0x0', 16:44:47 INFO - 'XPC_SERVICE_NAME': '0', 16:44:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:47 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/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--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 16:44:47 INFO - mozversion application_buildid: 20161008142616 16:44:47 INFO - mozversion application_changeset: 443a41b1b8f62de2866b162d09a545371abed2ba 16:44:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:44:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:47 INFO - mozversion application_name: Firefox 16:44:47 INFO - mozversion application_remotingname: firefox-dev 16:44:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:44:47 INFO - mozversion application_vendor: Mozilla 16:44:47 INFO - mozversion application_version: 51.0a2 16:44:47 INFO - mozversion platform_buildid: 20161008142616 16:44:47 INFO - mozversion platform_changeset: 443a41b1b8f62de2866b162d09a545371abed2ba 16:44:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:44:47 INFO - mozversion platform_version: 51.0a2 16:44:47 INFO - using testdate: 1475970287 16:44:47 INFO - actual date: 1475970287 16:44:47 INFO - starting webserver on 'localhost:49267' 16:44:47 INFO - SUITE-START | Running 2 tests 16:44:47 INFO - TEST-START | dromaeo_css 16:44:47 INFO - operating with platform_type : mac_ 16:44:47 INFO - Initialising browser for dromaeo_css test... 16:44:47 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp9L5nJo/profile http://localhost:49267/getInfo.html) 16:44:50 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 16:44:50 INFO - PROCESS | 1662 | colorDepth:24 16:44:50 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 16:44:50 INFO - PROCESS | 1662 | __metrics 16:44:50 INFO - PROCESS | 1662 | 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" 16:44:50 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:44:50 INFO - TEST-INFO | 1662: exit 0 16:44:50 INFO - Browser initialized. 16:44:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:50 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmp9L5nJo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:02 INFO - PROCESS | 1665 | RSS: Main: 219152384 16:45:02 INFO - PROCESS | 1665 | 16:45:53 INFO - PROCESS | 1665 | 1475970353759 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] 16:48:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 16:48:06 INFO - PROCESS | 1665 | RSS: Main: 320933888 16:48:06 INFO - PROCESS | 1665 | 16:51:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 16:51:10 INFO - PROCESS | 1665 | RSS: Main: 350502912 16:51:10 INFO - PROCESS | 1665 | 16:54:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 16:54:13 INFO - PROCESS | 1665 | RSS: Main: 325623808 16:54:13 INFO - PROCESS | 1665 | 16:57:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 16:57:16 INFO - PROCESS | 1665 | RSS: Main: 324833280 16:57:16 INFO - PROCESS | 1665 | 17:00:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 17:00:20 INFO - PROCESS | 1665 | RSS: Main: 310738944 17:00:20 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 17:03:23 INFO - PROCESS | 1665 | RSS: Main: 423837696 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | __start_tp_report 17:03:23 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 17:03:23 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 17:03:23 INFO - PROCESS | 1665 | |i|pagename|runs| 17:03:23 INFO - PROCESS | 1665 | |0;dojo.html;3350.949735753964;3356.9999999999995;3384.137045053511;3397.4564069748844;3426.3147370525885;5685.204071430003;5714.571407144465;5760.4815566599;5767.798127065548;5772.769089236436;5685.346185188704;5736.541076713864;5796.797112101077;5815.38938411467;5824.301083869931;5265.473452654723;5272.2592699337065;5287.947120528803;5298.178782288732;5316.760745766431;5204.115300398922;5214.921776173361;5215.947840521603;5351.866203344908;5367.838964831042;5269.8946021079555;5280.973595132019;5285.682859028451;5312.256284120226;5317.12267475866;4401.163778882003;5273.683578985273;5346.893062138735;5348.090824559834;5404.621676482648;4283.721558098745;5121.7439128043825;5281.8151364702435;5283.709395983219;5292.311999440087;4692.530746925314;5678.858028549278;5741.081426971707;5741.62679425836;5758.539316854642;6225.408586184305;6259.186305780265;6272.153259310026;6278.0269058296035;6324.71538780756;5482.5613950883835;6375;6375.2987171411105;6378.075179099051;6398.680065996728;5684.516816070639;5741.799037033684;5749.252597162342;5825.504832089235;5870.295564532241;6310.747570097236;6316.463100636405;6332.715027823759;6353;6354.046892965999;6205.627662340274;6242.812715618538;6243.125962365272;6254.15568898202;6259.374062593704;5177.430482646906;6106.21798979648;6252.6873656317;6338.841528961812;6347.0479428086155;6238.189035425366;6306.810795676137;6324.019776934582;6330.3669633036325;6353.809385718436;6289.779857704958;6326.9683651581445;6327.588706734047;6348.650824204713;6352.396522330371;4816.735079570657;4912;4965.32968049316;4975.975120124376;5004.299398084271;4440.511543730187;4461;4480.462344518679;4483.058557702919;4546.318052292183;5871.9706401468575;5873.001589729756;5878.764849406061;5882.911756323659;5893.263342082239;6346.555741098079;6364.331745166784;6379.457746091542;6380.298167201697;6392.328805475451;5668.348139963957;5671.829845104653;5698.971505142447;5733.655980641175;5782.45066718661;5453.754581043862;5461.4811592899405;5468.48049435303;5470.56235501159;5471.671699697951;6397.6801159941815;6406.039094135824;6406.295307516262;6406.583572067801;6409.294977552466;6145.262568491809;6245.344238855037;6265.624062556261;6363.490920726424;6368.904466432915;6303.086052522267;6362.840928976812;6364.64994425311;6390.913544697505;6401.199850018747;6265.624062556261;6269.749210031548;6277.340879207617;6279.215098112736;6288.685565721604;6026.939730602813;6166.229221347332;6298.0867774171575;6332;6355.809325720051;6059.909101363395;6078.756849725962;6130.092410195535;6180.721867515883;6185.41238582334;6153.384661533811;6201.410865967906;6210;6215.160953271251;6226.875462490634;5048.873778155576;5999.520038397005;6024.457798798129;6029.638221706711;6039.003564411999;6017.15759793638;6080.665563394055;6095.908561371672;6114.724837382418;6168.660723660242;5929.52563794904;5974.850628734316;5991.191189189403;6001.099835024606;6014.849628759316 17:03:23 INFO - PROCESS | 1665 | |1;ext.html;481.9060283244769;503.69274742407123;516.9250458683491;524.2215310264259;529.54988259979;22029.779702202974;38831.22337553251;40011.99999999996;40098.797036088894;40266.59733402665;40965;41437.792811035906;41463.75608731743;41469.792651036776;41527.37708934368;8082.999999999985;9671;9685.370450920704;9695.951520242388;9719.979402162777;8678.088800675932;8861;8868.33487488441;8999.775005624846;9010.414323069012;11738.7652246955;11949.522019119226;11968.581099661513;12212.267263964146;12223.69440763979;11835.467403966843;11995.820062699066;12007.159498835084;12027.879721202851;12034.217775844585;8556.5293908835;8772.166644168794;11671.824922626167;11747.765044699143;11749.588764393206;38546.22907541862;39164.412533812014;39185.80407097975;40751.79624101861;40830.59169408298;3192.9680703192903;3386.5766779152605;3414.726821854246;3862.517185351831;3898.571157172709;28917.132486025454;28945.131646050653;30302;30734.846325768453;31113.688863111533;3225.12921511193;3244.9675503244903;3262.9884735732;3263.3962716897213;3360.5463262459743;517690;520193;521132;536658;616246.8375316234;47892.76053619779;55664.443355566735;55861.44138558643;56149;59282;60003.099953500736;60267;60280.09579856306;60298;60303.69848150819;15757.842421575866;15974.680506389806;15992.520224393287;16000.519984400487;16010.759838602431;12486.875131248753;12811.743765124646;12813.231206127475;12814;12832.871671283168;13269.867301326864;13586.660333491543;15030.774538381933;15032.549023529093;15182;7178.641067946582;7227.096612923385;7290.4896657233485;7310.817229569197;7339.7064117435775;871.3900269811157;951.8286708392417;1013.2299452416216;1026.30211456209;1058.6136060338076;29443.558346624817;29677.961271355398;29924.551131733042;30298.69701303003;30344.393112137634;939.1500691873865;1009.0918173643779;1009.9747506312254;1076.5370890517154;1137.0051205195455;12227.69430764238;13146.934265328613;15222.238888055554;15543.922280388526;15746.606334841721;676753;682086;682495;683434;684263;48532;49204.34150072716;54979.725101374235;56598;56740.71629641826;1354.9661258468618;1358.2529608715167;1375.848656647768;1375.9587212383644;1376.1399125546534;29899.850500747358;31051.223719407197;31137.37725245437;31238.750449981748;31949;47156.29265561088;47609;47671.76164119157;47673.52326476691;47745.28382074341;345591;402610;407911;412152;412283;24962.37594060163;25257.873710631327;25269.87365063163;25321;25332.11337603249;45496;45523.41666088227;45607.77196113998;45758.313625296316;45914.85212869571;29653;36665;38096.80951595224;38124.61875381211;39111.804440978754;36770.89687309385;37442.43836342511;37461.94263774356;37685.86942391733;38560;36844.81577592202;37409;37610.8119459401;37657.2468550622;37724.43413348857;31996.48038715786;32185.517217241293;32896.83551582227;33250.501242480896;33621.49567756535;21262.78737212608;25174;25217.621735673612;25569.872150639127;25582.488350233263 17:03:23 INFO - PROCESS | 1665 | |2;jquery.html;354.21541286051394;364.3205421888178;373.4230613701831;374.5655040153422;379.0523690773067;14959.700805983888;15337;16205.756913646275;20821.27125550606;21317.253896113638;20383.082761275742;20741.274055408063;21057.789422105776;21276;21477.14091436341;5948.583599148062;5963.254593175842;6276.215473065867;6276.623402595859;6283.340249273829;5431.402545719968;5774.422557744213;6309.053641953721;6313.084602732601;6315.273743519485;3995.9200815983663;4080.4083407905837;5613.915791263134;6182.969085154568;6253.43719065284;6040.154378387029;6219.844503887393;6283.5287353448675;6287.591306565081;6295.590786598879;6099;6101.877962440726;6103.328633850273;6108.480779133779;6112.602680825732;12923.22460652364;12967.870321296761;13032;13084.934575327063;13245.271510066943;2166.4367264511184;2194.484296190394;2199.549092436047;2218.9334319970426;2934.2664333916523;9847.015298470096;9989.950050249776;10100.24248181382;10459.954004599555;10489.527971241236;1833.4316361927845;1843.6220574782137;1870.1116969439543;1876.1557299215272;2004.4888553418784;126044;136194.27611447716;137774;138126;141656.2917185428;11220.719482012852;11438.370889600985;11605.6518304451;11649.184557080924;11784.823227651592;14710.41158353654;14719;14724.263786810616;14730.55808325752;14746.926265368604;8515.829683406297;8576.571171441403;8589.65641374338;8617.267532259702;8751.737447876574;8590.312774977987;8608.053114157437;8634.050254472004;8746.387752857367;8746.431481953652;4504.549545045469;4507.616852567503;4515.300128480091;4522.208613492626;4612.800671825283;1861.1252711225702;1897.0514742628686;1907.5994041251492;1910.4746194796264;1910.92356305749;867.8915135608049;914.5792935249726;928.962841486333;968.4479846487435;984.7341217871135;20142.892140932097;21783.36860722791;21831.431718830194;21854.89072554627;21949.78050219509;932.8507438809758;945.6028468043438;960.519740129935;981.0225964198623;982.6953644370268;10463.895361046445;11334.603288885015;11354.54581816718;11384.20310578268;11501.827472587918;632987;636938;638535;643018;648226;109523.90476095297;111772;123417;124954;139519.90720139205;744.3301029073876;984.7390441532999;1016.5628779624684;1017.4099022566893;1018.2363227579316;18952.71570926465;19489;19529.902350488155;19668;19698.90150549238;57155.14267286077;57331.42668573428;58541.70729146327;58930.11604825845;59386.70306648439;75400.62299688686;84616.15383846083;84669.57665211635;85215;86656.83357916103;7904.156986309685;8019.558924259221;8072.354211663171;8443.113473085483;8456.66173353059;9327.533623318943;12571.245725256515;13226.156376379126;13310.667233318856;13572.864271357555;9280;11264.831027534758;11441.828372574251;11599.478023489131;11613.30320180792;11187.534117413334;11201.551937922392;11309.943450282695;11366.147538934778;11730.12024098213;11503.884961150281;11551.191416600757;11709;11734.413279335828;11953.521859125885;7881.857130716129;8020.719274825353;8258.463199892229;8359.247667709935;8428.283595894418;10190.286679932333;11319.09447244235;11447.713807154554;11531.8270225945;11595.13036522281 17:03:23 INFO - PROCESS | 1665 | |3;mootools.html;1532.7930729351535;1544.3282172255067;1720.7676963609908;1870.7100399438075;1888.291890541047;8477.703280385187;9041.502717350542;9045.954770226139;9050.45697258165;9080.682176123837;7844.764657060283;8063.475874068182;8087.191280871924;8563.229309362156;8794.604242809073;2377.7027871516016;2419.2016634510655;2419.5523828091773;2422.8667423291713;2424.8423852449623;2389.6176611742126;2395.3891757601787;2402.4714562796157;2428.502157057808;2430.368104292888;2001.9689859722255;2030.2893987104544;2395.3532546212514;2397.4965257295903;2399.664047033417;1996.8901710405921;2368.325027367192;2386.4391867911027;2392.485615592656;2399.2802159352213;2382.3805810489225;2387.940301492459;2395.2694428199393;2395.5208958208254;2395.5448464791634;8893.822123557493;8917.955410222972;8988.820223595492;8994.235489983359;9012.369134160612;5286.497782710637;5449.073657478199;5451.291332126838;5457.508824205801;5468.589855760833;3504.0013596125236;3590.299891521154;3706.2031663192274;3722.274156539476;3724.1992971511254;1103.9779204415868;1105.729096371386;1108.2519299472904;1130.3387518301804;1130.7455822439968;8669;11923.582674606347;11939.462724177347;11939.985101266402;12476.563320283747;4280.614744672932;4392.2752745797225;4513.50351461339;4642.303654451859;4889.193283108319;9486.478243696663;10110.949445252727;10113.342632728849;10124.291299609104;10125.64560240388;5411.594130440233;5419.620626556103;5422.6475279106735;5426.701531415731;5428.864278393072;4456.22016147173;4485.910281794346;4902.240152776325;4922.310876477296;4952.133376659142;4000.7999600019884;4012.117334186474;4086.468759061303;4116.135611521554;4130.524989626171;1295.242283264301;1305.484333688188;1305.4843336882068;1317.466426097432;1319.511780641169;912.9680461183826;918.8695721203376;928.6842473558887;930.7021753039098;982.872226610536;4905.877353066202;5660;5669.6314739541795;6067.484263837535;6223;432.23494414885477;440.0025765916619;444.87098741365287;449.6200710399707;463.9396878405786;3984.183242435294;3994;4000.4799376080923;4048.5344185418467;4059.167870586523;10474.266801323834;10779.02988731018;10848.294860834021;10867.076298514714;10899.618513351994;10729.141668666489;10748.570057197625;10790.51442685081;10801.459927003618;10810.135189184846;7828.217178282126;8115.513069215866;8182;8203.671853125808;8217.972753405824;5975.611585246945;6010.699465026643;6038.818835434944;6052.760478622938;6111.511079113571;9991.950040250043;10269;10272.691819245434;10278.229132815219;10291.485425728833;10025.949870250603;10076.244281678757;10305.227107967083;10393.16854651611;10467.319624224401;6484.254310754323;7054.118235220598;7295.708171673074;7484.663190156347;7547.547147171187;8424;8557.700480483154;8562.700305489527;8562.957185214034;8566.614502347535;6266.968665156645;7443.851122977402;7585.772426827204;7616.8476630468185;7698.153203147537;7431.145418276968;7466.8506629866015;7499.475036747375;7513.774586762406;7642.388608911385;6961.58230506151;7128.786136415916;7133.714651414093;7139.535930164523;7143.749968751069;5002.499750024968;5059.974700126476;5069.695818250917;5099.490050994871;5175;5047.596192304533;5052.8484145475695;5181.53366197044;5191.948080519146;5222.686638801684 17:03:23 INFO - PROCESS | 1665 | |4;prototype.html;302.67764830455565;304.22878004259223;311.270071681906;314.42460297655293;316.92235402326435;5216.052930094504;5452.263944367519;5504.889902201959;5521.668699878005;5535.924028489317;5282.366116066068;5345.599080068991;5376.03774622263;5403.891922161564;5453.2092846537325;3314.535964964901;3529.470579413096;4087.7093939378788;4146.896327591804;4150.564190759972;3838.6545210931013;4085.12169883475;4167.958320416802;4180.811863466151;4191.874243772677;3558.3594952908466;4022.45696830927;4047.5547689754103;4077.938830917539;4098.52866920305;4078.877633670995;4091.2226676931286;4091.365838295069;4095.3242714952;4104.384342348641;2939.617849679549;3118.7836743669986;3135.8902438414775;3284.770066095374;3331.4503106987318;4579.702319349231;4674.532546745332;5069.518395752398;5257.737113144328;5272.576404370837;3741.756785808941;4311.461067366579;4661.6969896956925;4672.742999135046;4700.600448961808;5331.293985924506;5712.6001179917;5735.627184233012;5755.194272801811;5761.510271626917;3526.982365088184;3835.5972622874474;3839.214765134226;3853;3860.8148277671035;4928.728919909404;6022.337542870281;6086.939130608682;6112.877742445171;6118.969405152946;3537.6816086552335;3714.888553343404;3797.905052373713;3915.647591716759;4058.8690937257584;3485.233248685285;4097.672186225095;4128.545859955402;4134.545200028055;4149.937750933738;4761.262004389325;4785.784639691222;4795.160846851787;4803.927941080817;4820.180569303227;5569.164625306236;5791.739371728282;5809.070548712186;5817.38917413674;5854.677992710442;1209.8548174218975;1389.2703584037938;1411.2802470739996;1416.6175132714109;1423.1603354021177;737.2821326309686;825.7068740597122;864.3085531574841;867.3321542412307;872.1932212703224;3933.704972127102;4433.46798384196;4501.009777848868;4512.2329204035395;4537.750423726727;4295.914081718348;4344.827586206897;4401.911961760747;4458.08609235106;4579.450465944042;3592.9101772455374;4210.305299625588;4396.384506169139;4490.7754612269255;4519.570640789119;2211.1818627108073;2420.5400973814917;2602.856842873622;2624.9868750656506;2636.49906517761;4591.47198072226;5081.949180508148;5125.359330083739;5142.434332223453;5237.559671090405;4813.446453657874;4882.803713090316;5010.444673216686;5026.421961474477;5129.64092513528;3959.742616729903;4447.421835161408;4978.278149668277;5065.797368105308;5171.043356978971;4866.537678920497;4895.4370247422;4906.533879281463;4906.803727850989;4916.434610019751;4207.1375368050085;4346.9130617386845;4842.8619274471175;4875.0493653737185;4921.409430868319;4526.886827829199;4545.795439205178;4659;5056.62075344358;5103.2491119026745;3487.459443786217;3787.5833658298116;3898.6101389860787;3927.4501569780823;3928.66606338453;5178.042062218502;5232.659877108128;5862.765489380377;5867.413258674099;5964.642121472725;5009.5491405773655;5611.963988988401;5745.971270143623;5764.394738552392;5787.508061814793;4544.18204723153;5119.846404607868;5152.536271735562;5272.78908843642;5693.829185124453;5161.225816127611;5591.4688104629995;5660.867566676432;5677.9495793278375;5684.459976302244;4990;5362.176859867664;5464.278752193047;5530.695811730233;5725.08398656213;5540.390557038803;5573.331200255995;5583.41374155724;5586.804461843816;5607.719614019201 17:03:23 INFO - PROCESS | 1665 | |5;yui.html;775.4726785785665;784.580249566482;784.7449578886864;789.7235967411407;795.5743677132735;14997.100173989555;16053.438129665436;16098.114603696822;16217.108059056747;16217.75673364899;14416.92791536041;14578.416863325481;14591.854081459182;14623.122612643248;14639.341229644664;679.6397909108156;706.6608028146493;835.2566216067675;841.1798496465958;863.2619110660389;811.059171361221;812.0539571399313;821.9876701849447;855.4097672605914;857.5412154497345;708.1926603671818;902.8961669408036;903.6520939438298;905.7463910105181;906.8050369170627;725.9128904531437;886.4991279926853;900.0324651000136;901.5357091098024;911.2436677557678;674.6289540752566;675.4056430341317;675.5710124071201;676.3338111959715;678.8642271545662;15055.322510487054;15060.246987650573;15073.773893391608;15077;15077.396904123822;13691.726165476635;13928.233947132903;14021.9483538735;14118;14224.217668028254;12540.623781286577;12804.743905121846;12972.610821675271;13015.219086854819;13349.132306400053;4509.571590698878;4518.367428560005;4548.612673134692;4566.1552612766745;4712.387389639325;122706.77293227043;128001;128146.35926820399;129181;131305;10844.295120817122;11016.283941543774;11149.331040137618;11167;11290.435478226056;21905;22063.66904496434;22116.115355385606;22122.557548848934;22132;7041.767690654115;7724.613769311624;7843.647035883285;7989.520628762293;8115.594220288962;4302.892427689333;4359.67302452311;4381.277089280233;4446.421965144576;4546.909061818745;3458.3256265028076;3605.3330133924783;3606.513120728668;3606.765560238576;3609.1698909251018;642.502060902804;659.970301336441;666.1839246922578;667.8630880669451;671.785028790792;580.5065694160014;606.1967892542399;615.9744026196333;622.2244275188004;629.4052120745943;9075.3364796364;9080.228180604723;9086.772830679285;9105.590248438835;9189.448633082036;576.4840467781312;609.1532769450467;627.5889292513411;628.1300398947491;632.5445679111033;4464.620507256855;4466.798994045275;4493.73037617744;4529.116822219636;4566.246569316026;106281;128132;149892;168025;179794;103647;133731;137544;138860;145200;113714;117527.41236293934;125121.74878251283;129179.31155163213;129751;8451.197136272045;8685.478871267744;8854.867176992222;8905.332100092648;8960.417572857743;67603.30991725049;69386.30613694001;69483.65258173677;70283.94574081291;70414;101397.49301253447;103264;106459.46770266099;107997.3800392979;109561.45219273852;10751.516181771683;10760.3543787373;11046.944765276123;11471.655850324503;11530.365829879102;11964.162508624313;12276.938615306866;12600;12831;12883.742325153256;10973.341599504056;11802.055835533309;11817.645470635895;11827.791639590701;12164.452599633214;12012.33932133706;12187.268763874195;12208.938955305166;12533.686657833627;12572;11629.418529073682;11903.047756179312;11943.402829858645;12054.638360849189;12337.50649973991;9365.859512107187;10035;10050.497475126069;10909.563617455531;11804.542821183686;11662.300261984308;11803.350815705218;11864.76270474603;11920.523179073087;11929.701757456132 17:03:23 INFO - PROCESS | 1665 | __end_tp_report 17:03:23 INFO - PROCESS | 1665 | __start_cc_report 17:03:23 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1385 17:03:23 INFO - PROCESS | 1665 | __end_cc_report 17:03:23 INFO - PROCESS | 1665 | __startTimestamp1475971403584__endTimestamp 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | ------- Summary: start ------- 17:03:23 INFO - PROCESS | 1665 | Number of tests: 6 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5776.48 Median:6001.10 stddev:671.78 (11.2%) stddev-sans-first:646.33 17:03:23 INFO - PROCESS | 1665 | Values: 3350.9 3357.0 3384.1 3397.5 3426.3 5685.2 5714.6 5760.5 5767.8 5772.8 5685.3 5736.5 5796.8 5815.4 5824.3 5265.5 5272.3 5287.9 5298.2 5316.8 5204.1 5214.9 5215.9 5351.9 5367.8 5269.9 5281.0 5285.7 5312.3 5317.1 4401.2 5273.7 5346.9 5348.1 5404.6 4283.7 5121.7 5281.8 5283.7 5292.3 4692.5 5678.9 5741.1 5741.6 5758.5 6225.4 6259.2 6272.2 6278.0 6324.7 5482.6 6375.0 6375.3 6378.1 6398.7 5684.5 5741.8 5749.3 5825.5 5870.3 6310.7 6316.5 6332.7 6353.0 6354.0 6205.6 6242.8 6243.1 6254.2 6259.4 5177.4 6106.2 6252.7 6338.8 6347.0 6238.2 6306.8 6324.0 6330.4 6353.8 6289.8 6327.0 6327.6 6348.7 6352.4 4816.7 4912.0 4965.3 4976.0 5004.3 4440.5 4461.0 4480.5 4483.1 4546.3 5872.0 5873.0 5878.8 5882.9 5893.3 6346.6 6364.3 6379.5 6380.3 6392.3 5668.3 5671.8 5699.0 5733.7 5782.5 5453.8 5461.5 5468.5 5470.6 5471.7 6397.7 6406.0 6406.3 6406.6 6409.3 6145.3 6245.3 6265.6 6363.5 6368.9 6303.1 6362.8 6364.6 6390.9 6401.2 6265.6 6269.7 6277.3 6279.2 6288.7 6026.9 6166.2 6298.1 6332.0 6355.8 6059.9 6078.8 6130.1 6180.7 6185.4 6153.4 6201.4 6210.0 6215.2 6226.9 5048.9 5999.5 6024.5 6029.6 6039.0 6017.2 6080.7 6095.9 6114.7 6168.7 5929.5 5974.9 5991.2 6001.1 6014.8 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:67012.15 Median:37452.19 stddev:148132.22 (395.5%) stddev-sans-first:148463.55 17:03:23 INFO - PROCESS | 1665 | Values: 481.9 503.7 516.9 524.2 529.5 22029.8 38831.2 40012.0 40098.8 40266.6 40965.0 41437.8 41463.8 41469.8 41527.4 8083.0 9671.0 9685.4 9696.0 9720.0 8678.1 8861.0 8868.3 8999.8 9010.4 11738.8 11949.5 11968.6 12212.3 12223.7 11835.5 11995.8 12007.2 12027.9 12034.2 8556.5 8772.2 11671.8 11747.8 11749.6 38546.2 39164.4 39185.8 40751.8 40830.6 3193.0 3386.6 3414.7 3862.5 3898.6 28917.1 28945.1 30302.0 30734.8 31113.7 3225.1 3245.0 3263.0 3263.4 3360.5 517690.0 520193.0 521132.0 536658.0 616246.8 47892.8 55664.4 55861.4 56149.0 59282.0 60003.1 60267.0 60280.1 60298.0 60303.7 15757.8 15974.7 15992.5 16000.5 16010.8 12486.9 12811.7 12813.2 12814.0 12832.9 13269.9 13586.7 15030.8 15032.5 15182.0 7178.6 7227.1 7290.5 7310.8 7339.7 871.4 951.8 1013.2 1026.3 1058.6 29443.6 29678.0 29924.6 30298.7 30344.4 939.2 1009.1 1010.0 1076.5 1137.0 12227.7 13146.9 15222.2 15543.9 15746.6 676753.0 682086.0 682495.0 683434.0 684263.0 48532.0 49204.3 54979.7 56598.0 56740.7 1355.0 1358.3 1375.8 1376.0 1376.1 29899.9 31051.2 31137.4 31238.8 31949.0 47156.3 47609.0 47671.8 47673.5 47745.3 345591.0 402610.0 407911.0 412152.0 412283.0 24962.4 25257.9 25269.9 25321.0 25332.1 45496.0 45523.4 45607.8 45758.3 45914.9 29653.0 36665.0 38096.8 38124.6 39111.8 36770.9 37442.4 37461.9 37685.9 38560.0 36844.8 37409.0 37610.8 37657.2 37724.4 31996.5 32185.5 32896.8 33250.5 33621.5 21262.8 25174.0 25217.6 25569.9 25582.5 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36518.83 Median:12074.66 stddev:106871.50 (885.1%) stddev-sans-first:107136.80 17:03:23 INFO - PROCESS | 1665 | Values: 354.2 364.3 373.4 374.6 379.1 14959.7 15337.0 16205.8 20821.3 21317.3 20383.1 20741.3 21057.8 21276.0 21477.1 5948.6 5963.3 6276.2 6276.6 6283.3 5431.4 5774.4 6309.1 6313.1 6315.3 3995.9 4080.4 5613.9 6183.0 6253.4 6040.2 6219.8 6283.5 6287.6 6295.6 6099.0 6101.9 6103.3 6108.5 6112.6 12923.2 12967.9 13032.0 13084.9 13245.3 2166.4 2194.5 2199.5 2218.9 2934.3 9847.0 9990.0 10100.2 10460.0 10489.5 1833.4 1843.6 1870.1 1876.2 2004.5 126044.0 136194.3 137774.0 138126.0 141656.3 11220.7 11438.4 11605.7 11649.2 11784.8 14710.4 14719.0 14724.3 14730.6 14746.9 8515.8 8576.6 8589.7 8617.3 8751.7 8590.3 8608.1 8634.1 8746.4 8746.4 4504.5 4507.6 4515.3 4522.2 4612.8 1861.1 1897.1 1907.6 1910.5 1910.9 867.9 914.6 929.0 968.4 984.7 20142.9 21783.4 21831.4 21854.9 21949.8 932.9 945.6 960.5 981.0 982.7 10463.9 11334.6 11354.5 11384.2 11501.8 632987.0 636938.0 638535.0 643018.0 648226.0 109523.9 111772.0 123417.0 124954.0 139519.9 744.3 984.7 1016.6 1017.4 1018.2 18952.7 19489.0 19529.9 19668.0 19698.9 57155.1 57331.4 58541.7 58930.1 59386.7 75400.6 84616.2 84669.6 85215.0 86656.8 7904.2 8019.6 8072.4 8443.1 8456.7 9327.5 12571.2 13226.2 13310.7 13572.9 9280.0 11264.8 11441.8 11599.5 11613.3 11187.5 11201.6 11309.9 11366.1 11730.1 11503.9 11551.2 11709.0 11734.4 11953.5 7881.9 8020.7 8258.5 8359.2 8428.3 10190.3 11319.1 11447.7 11531.8 11595.1 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5734.57 Median:2488.72 stddev:3230.42 (129.8%) stddev-sans-first:3224.05 17:03:23 INFO - PROCESS | 1665 | Values: 1532.8 1544.3 1720.8 1870.7 1888.3 8477.7 9041.5 9046.0 9050.5 9080.7 7844.8 8063.5 8087.2 8563.2 8794.6 2377.7 2419.2 2419.6 2422.9 2424.8 2389.6 2395.4 2402.5 2428.5 2430.4 2002.0 2030.3 2395.4 2397.5 2399.7 1996.9 2368.3 2386.4 2392.5 2399.3 2382.4 2387.9 2395.3 2395.5 2395.5 8893.8 8918.0 8988.8 8994.2 9012.4 5286.5 5449.1 5451.3 5457.5 5468.6 3504.0 3590.3 3706.2 3722.3 3724.2 1104.0 1105.7 1108.3 1130.3 1130.7 8669.0 11923.6 11939.5 11940.0 12476.6 4280.6 4392.3 4513.5 4642.3 4889.2 9486.5 10110.9 10113.3 10124.3 10125.6 5411.6 5419.6 5422.6 5426.7 5428.9 4456.2 4485.9 4902.2 4922.3 4952.1 4000.8 4012.1 4086.5 4116.1 4130.5 1295.2 1305.5 1305.5 1317.5 1319.5 913.0 918.9 928.7 930.7 982.9 4905.9 5660.0 5669.6 6067.5 6223.0 432.2 440.0 444.9 449.6 463.9 3984.2 3994.0 4000.5 4048.5 4059.2 10474.3 10779.0 10848.3 10867.1 10899.6 10729.1 10748.6 10790.5 10801.5 10810.1 7828.2 8115.5 8182.0 8203.7 8218.0 5975.6 6010.7 6038.8 6052.8 6111.5 9992.0 10269.0 10272.7 10278.2 10291.5 10025.9 10076.2 10305.2 10393.2 10467.3 6484.3 7054.1 7295.7 7484.7 7547.5 8424.0 8557.7 8562.7 8563.0 8566.6 6267.0 7443.9 7585.8 7616.8 7698.2 7431.1 7466.9 7499.5 7513.8 7642.4 6961.6 7128.8 7133.7 7139.5 7143.7 5002.5 5060.0 5069.7 5099.5 5175.0 5047.6 5052.8 5181.5 5191.9 5222.7 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4356.69 Median:4730.93 stddev:1338.93 (28.3%) stddev-sans-first:1307.65 17:03:23 INFO - PROCESS | 1665 | Values: 302.7 304.2 311.3 314.4 316.9 5216.1 5452.3 5504.9 5521.7 5535.9 5282.4 5345.6 5376.0 5403.9 5453.2 3314.5 3529.5 4087.7 4146.9 4150.6 3838.7 4085.1 4168.0 4180.8 4191.9 3558.4 4022.5 4047.6 4077.9 4098.5 4078.9 4091.2 4091.4 4095.3 4104.4 2939.6 3118.8 3135.9 3284.8 3331.5 4579.7 4674.5 5069.5 5257.7 5272.6 3741.8 4311.5 4661.7 4672.7 4700.6 5331.3 5712.6 5735.6 5755.2 5761.5 3527.0 3835.6 3839.2 3853.0 3860.8 4928.7 6022.3 6086.9 6112.9 6119.0 3537.7 3714.9 3797.9 3915.6 4058.9 3485.2 4097.7 4128.5 4134.5 4149.9 4761.3 4785.8 4795.2 4803.9 4820.2 5569.2 5791.7 5809.1 5817.4 5854.7 1209.9 1389.3 1411.3 1416.6 1423.2 737.3 825.7 864.3 867.3 872.2 3933.7 4433.5 4501.0 4512.2 4537.8 4295.9 4344.8 4401.9 4458.1 4579.5 3592.9 4210.3 4396.4 4490.8 4519.6 2211.2 2420.5 2602.9 2625.0 2636.5 4591.5 5081.9 5125.4 5142.4 5237.6 4813.4 4882.8 5010.4 5026.4 5129.6 3959.7 4447.4 4978.3 5065.8 5171.0 4866.5 4895.4 4906.5 4906.8 4916.4 4207.1 4346.9 4842.9 4875.0 4921.4 4526.9 4545.8 4659.0 5056.6 5103.2 3487.5 3787.6 3898.6 3927.5 3928.7 5178.0 5232.7 5862.8 5867.4 5964.6 5009.5 5612.0 5746.0 5764.4 5787.5 4544.2 5119.8 5152.5 5272.8 5693.8 5161.2 5591.5 5660.9 5677.9 5684.5 4990.0 5362.2 5464.3 5530.7 5725.1 5540.4 5573.3 5583.4 5586.8 5607.7 17:03:23 INFO - PROCESS | 1665 | 17:03:23 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:26145.35 Median:22089.89 stddev:42807.21 (193.8%) stddev-sans-first:42884.92 17:03:23 INFO - PROCESS | 1665 | Values: 775.5 784.6 784.7 789.7 795.6 14997.1 16053.4 16098.1 16217.1 16217.8 14416.9 14578.4 14591.9 14623.1 14639.3 679.6 706.7 835.3 841.2 863.3 811.1 812.1 822.0 855.4 857.5 708.2 902.9 903.7 905.7 906.8 725.9 886.5 900.0 901.5 911.2 674.6 675.4 675.6 676.3 678.9 15055.3 15060.2 15073.8 15077.0 15077.4 13691.7 13928.2 14021.9 14118.0 14224.2 12540.6 12804.7 12972.6 13015.2 13349.1 4509.6 4518.4 4548.6 4566.2 4712.4 122706.8 128001.0 128146.4 129181.0 131305.0 10844.3 11016.3 11149.3 11167.0 11290.4 21905.0 22063.7 22116.1 22122.6 22132.0 7041.8 7724.6 7843.6 7989.5 8115.6 4302.9 4359.7 4381.3 4446.4 4546.9 3458.3 3605.3 3606.5 3606.8 3609.2 642.5 660.0 666.2 667.9 671.8 580.5 606.2 616.0 622.2 629.4 9075.3 9080.2 9086.8 9105.6 9189.4 576.5 609.2 627.6 628.1 632.5 4464.6 4466.8 4493.7 4529.1 4566.2 106281.0 128132.0 149892.0 168025.0 179794.0 103647.0 133731.0 137544.0 138860.0 145200.0 113714.0 117527.4 125121.7 129179.3 129751.0 8451.2 8685.5 8854.9 8905.3 8960.4 67603.3 69386.3 69483.7 70283.9 70414.0 101397.5 103264.0 106459.5 107997.4 109561.5 10751.5 10760.4 11046.9 11471.7 11530.4 11964.2 12276.9 12600.0 12831.0 12883.7 10973.3 11802.1 11817.6 11827.8 12164.5 12012.3 12187.3 12208.9 12533.7 12572.0 11629.4 11903.0 11943.4 12054.6 12337.5 9365.9 10035.0 10050.5 10909.6 11804.5 11662.3 11803.4 11864.8 11920.5 11929.7 17:03:23 INFO - PROCESS | 1665 | -------- Summary: end -------- 17:03:23 INFO - PROCESS | 1665 | 17:03:24 INFO - TEST-INFO | 1665: exit 0 17:03:24 INFO - TEST-OK | dromaeo_css | took 1116717ms 17:03:24 INFO - TEST-START | kraken 17:03:24 INFO - operating with platform_type : mac_ 17:03:24 INFO - Initialising browser for kraken test... 17:03:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpcRevQb/profile http://localhost:49267/getInfo.html) 17:03:26 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 17:03:26 INFO - PROCESS | 1671 | colorDepth:24 17:03:26 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 17:03:26 INFO - PROCESS | 1671 | __metrics 17:03:26 INFO - PROCESS | 1671 | 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" 17:03:26 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:27 INFO - TEST-INFO | 1671: exit 0 17:03:27 INFO - Browser initialized. 17:03:27 INFO - Running cycle 1/1 for kraken test... 17:03:27 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpcRevQb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:39 INFO - PROCESS | 1672 | RSS: Main: 220164096 17:03:39 INFO - PROCESS | 1672 | 17:03:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:43 INFO - PROCESS | 1672 | RSS: Main: 270426112 17:03:43 INFO - PROCESS | 1672 | 17:03:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 17:03:46 INFO - PROCESS | 1672 | RSS: Main: 280428544 17:03:46 INFO - PROCESS | 1672 | 17:03:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 17:03:50 INFO - PROCESS | 1672 | RSS: Main: 376377344 17:03:50 INFO - PROCESS | 1672 | 17:03:51 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 17:03:52 INFO - PROCESS | 1672 | RSS: Main: 279793664 17:03:52 INFO - PROCESS | 1672 | 17:03:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:55 INFO - PROCESS | 1672 | RSS: Main: 280666112 17:03:55 INFO - PROCESS | 1672 | 17:03:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:58 INFO - PROCESS | 1672 | RSS: Main: 318058496 17:03:58 INFO - PROCESS | 1672 | 17:04:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:02 INFO - PROCESS | 1672 | RSS: Main: 318529536 17:04:02 INFO - PROCESS | 1672 | 17:04:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 17:04:05 INFO - PROCESS | 1672 | RSS: Main: 314544128 17:04:05 INFO - PROCESS | 1672 | 17:04:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:07 INFO - PROCESS | 1672 | RSS: Main: 295673856 17:04:07 INFO - PROCESS | 1672 | 17:04:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:10 INFO - PROCESS | 1672 | RSS: Main: 298045440 17:04:10 INFO - PROCESS | 1672 | 17:04:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:13 INFO - PROCESS | 1672 | RSS: Main: 300326912 17:04:13 INFO - PROCESS | 1672 | 17:04:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:16 INFO - PROCESS | 1672 | RSS: Main: 311566336 17:04:16 INFO - PROCESS | 1672 | 17:04:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:20 INFO - PROCESS | 1672 | RSS: Main: 310362112 17:04:20 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 17:04:22 INFO - PROCESS | 1672 | RSS: Main: 354410496 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | __start_tp_report 17:04:22 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 17:04:22 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 17:04:22 INFO - PROCESS | 1672 | |i|pagename|runs| 17:04:22 INFO - PROCESS | 1672 | |0;ai-astar;116;114;114;115;115;116;113;122;170;152 17:04:22 INFO - PROCESS | 1672 | |1;audio-beat-detection;145;108;110;141;113;109;109;106;137;109 17:04:22 INFO - PROCESS | 1672 | |2;audio-dft;181;182;184;184;183;182;181;183;182;183 17:04:22 INFO - PROCESS | 1672 | |3;audio-fft;78;58;60;88;60;59;60;58;83;58 17:04:22 INFO - PROCESS | 1672 | |4;audio-oscillator;88;70;93;70;67;68;92;70;68;89 17:04:22 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;86;89;88;88;85;88;86;89;84 17:04:22 INFO - PROCESS | 1672 | |6;imaging-darkroom;93;95;94;95;101;149;138;93;94;94 17:04:22 INFO - PROCESS | 1672 | |7;imaging-desaturate;84;84;86;86;83;85;85;83;85;87 17:04:22 INFO - PROCESS | 1672 | |8;json-parse-financial;53;53;52;53;57;55;62;79;89;89 17:04:22 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;63;75;76;76;72;69;69;69;71;70 17:04:22 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;90;101;103;83;82;85;82;83;83;100 17:04:22 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;138;144;151;151;137;140;140;141;176;163 17:04:22 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;163;162;161;164;163;164;163;163;162;166 17:04:22 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;67;68;71;86;85;87;83;85;75;67 17:04:22 INFO - PROCESS | 1672 | __end_tp_report 17:04:22 INFO - PROCESS | 1672 | __start_cc_report 17:04:22 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1920 17:04:22 INFO - PROCESS | 1672 | __end_cc_report 17:04:22 INFO - PROCESS | 1672 | __startTimestamp1475971462459__endTimestamp 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | ------- Summary: start ------- 17:04:22 INFO - PROCESS | 1672 | Number of tests: 14 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:124.70 Median:116.00 stddev:19.75 (17.0%) stddev-sans-first:20.69 17:04:22 INFO - PROCESS | 1672 | Values: 116.0 114.0 114.0 115.0 115.0 116.0 113.0 122.0 170.0 152.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:111.50 stddev:15.60 (14.0%) stddev-sans-first:13.33 17:04:22 INFO - PROCESS | 1672 | Values: 145.0 108.0 110.0 141.0 113.0 109.0 109.0 106.0 137.0 109.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.08 (0.6%) stddev-sans-first:1.00 17:04:22 INFO - PROCESS | 1672 | Values: 181.0 182.0 184.0 184.0 183.0 182.0 181.0 183.0 182.0 183.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:11.86 (19.8%) stddev-sans-first:11.78 17:04:22 INFO - PROCESS | 1672 | Values: 78.0 58.0 60.0 88.0 60.0 59.0 60.0 58.0 83.0 58.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:11.32 (14.3%) stddev-sans-first:11.35 17:04:22 INFO - PROCESS | 1672 | Values: 88.0 70.0 93.0 70.0 67.0 68.0 92.0 70.0 68.0 89.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.73 (2.0%) stddev-sans-first:1.80 17:04:22 INFO - PROCESS | 1672 | Values: 88.0 86.0 89.0 88.0 88.0 85.0 88.0 86.0 89.0 84.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:94.00 stddev:20.79 (22.1%) stddev-sans-first:21.62 17:04:22 INFO - PROCESS | 1672 | Values: 93.0 95.0 94.0 95.0 101.0 149.0 138.0 93.0 94.0 94.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.32 (1.5%) stddev-sans-first:1.36 17:04:22 INFO - PROCESS | 1672 | Values: 84.0 84.0 86.0 86.0 83.0 85.0 85.0 83.0 85.0 87.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:59.50 stddev:15.33 (25.8%) stddev-sans-first:15.72 17:04:22 INFO - PROCESS | 1672 | Values: 53.0 53.0 52.0 53.0 57.0 55.0 62.0 79.0 89.0 89.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:4.00 (5.6%) stddev-sans-first:3.02 17:04:22 INFO - PROCESS | 1672 | Values: 63.0 75.0 76.0 76.0 72.0 69.0 69.0 69.0 71.0 70.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:83.00 stddev:8.72 (10.5%) stddev-sans-first:9.24 17:04:22 INFO - PROCESS | 1672 | Values: 90.0 101.0 103.0 83.0 82.0 85.0 82.0 83.0 83.0 100.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:147.50 stddev:12.65 (8.6%) stddev-sans-first:12.88 17:04:22 INFO - PROCESS | 1672 | Values: 138.0 144.0 151.0 151.0 137.0 140.0 140.0 141.0 176.0 163.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 17:04:22 INFO - PROCESS | 1672 | Values: 163.0 162.0 161.0 164.0 163.0 164.0 163.0 163.0 162.0 166.0 17:04:22 INFO - PROCESS | 1672 | 17:04:22 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:84.00 stddev:8.59 (10.2%) stddev-sans-first:8.25 17:04:22 INFO - PROCESS | 1672 | Values: 67.0 68.0 71.0 86.0 85.0 87.0 83.0 85.0 75.0 67.0 17:04:22 INFO - PROCESS | 1672 | -------- Summary: end -------- 17:04:22 INFO - PROCESS | 1672 | 17:04:23 INFO - TEST-INFO | 1672: exit 0 17:04:23 INFO - TEST-OK | kraken | took 59123ms 17:04:23 INFO - SUITE-END | took 1175s 17:04:23 INFO - Completed test suite (00:19:36) 17:04:23 INFO - javascript benchmark 17:04:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.949735753964, 3356.9999999999995, 3384.137045053511, 3397.4564069748844, 3426.3147370525885, 5685.204071430003, 5714.571407144465, 5760.4815566599, 5767.798127065548, 5772.769089236436, 5685.346185188704, 5736.541076713864, 5796.797112101077, 5815.38938411467, 5824.301083869931, 5265.473452654723, 5272.2592699337065, 5287.947120528803, 5298.178782288732, 5316.760745766431, 5204.115300398922, 5214.921776173361, 5215.947840521603, 5351.866203344908, 5367.838964831042, 5269.8946021079555, 5280.973595132019, 5285.682859028451, 5312.256284120226, 5317.12267475866, 4401.163778882003, 5273.683578985273, 5346.893062138735, 5348.090824559834, 5404.621676482648, 4283.721558098745, 5121.7439128043825, 5281.8151364702435, 5283.709395983219, 5292.311999440087, 4692.530746925314, 5678.858028549278, 5741.081426971707, 5741.62679425836, 5758.539316854642, 6225.408586184305, 6259.186305780265, 6272.153259310026, 6278.0269058296035, 6324.71538780756, 5482.5613950883835, 6375.0, 6375.2987171411105, 6378.075179099051, 6398.680065996728, 5684.516816070639, 5741.799037033684, 5749.252597162342, 5825.504832089235, 5870.295564532241, 6310.747570097236, 6316.463100636405, 6332.715027823759, 6353.0, 6354.046892965999, 6205.627662340274, 6242.812715618538, 6243.125962365272, 6254.15568898202, 6259.374062593704, 5177.430482646906, 6106.21798979648, 6252.6873656317, 6338.841528961812, 6347.0479428086155, 6238.189035425366, 6306.810795676137, 6324.019776934582, 6330.3669633036325, 6353.809385718436, 6289.779857704958, 6326.9683651581445, 6327.588706734047, 6348.650824204713, 6352.396522330371, 4816.735079570657, 4912.0, 4965.32968049316, 4975.975120124376, 5004.299398084271, 4440.511543730187, 4461.0, 4480.462344518679, 4483.058557702919, 4546.318052292183, 5871.9706401468575, 5873.001589729756, 5878.764849406061, 5882.911756323659, 5893.263342082239, 6346.555741098079, 6364.331745166784, 6379.457746091542, 6380.298167201697, 6392.328805475451, 5668.348139963957, 5671.829845104653, 5698.971505142447, 5733.655980641175, 5782.45066718661, 5453.754581043862, 5461.4811592899405, 5468.48049435303, 5470.56235501159, 5471.671699697951, 6397.6801159941815, 6406.039094135824, 6406.295307516262, 6406.583572067801, 6409.294977552466, 6145.262568491809, 6245.344238855037, 6265.624062556261, 6363.490920726424, 6368.904466432915, 6303.086052522267, 6362.840928976812, 6364.64994425311, 6390.913544697505, 6401.199850018747, 6265.624062556261, 6269.749210031548, 6277.340879207617, 6279.215098112736, 6288.685565721604, 6026.939730602813, 6166.229221347332, 6298.0867774171575, 6332.0, 6355.809325720051, 6059.909101363395, 6078.756849725962, 6130.092410195535, 6180.721867515883, 6185.41238582334, 6153.384661533811, 6201.410865967906, 6210.0, 6215.160953271251, 6226.875462490634, 5048.873778155576, 5999.520038397005, 6024.457798798129, 6029.638221706711, 6039.003564411999, 6017.15759793638, 6080.665563394055, 6095.908561371672, 6114.724837382418, 6168.660723660242, 5929.52563794904, 5974.850628734316, 5991.191189189403, 6001.099835024606, 6014.849628759316], "value": 5733.583267141942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.9060283244769, 503.69274742407123, 516.9250458683491, 524.2215310264259, 529.54988259979, 22029.779702202974, 38831.22337553251, 40011.99999999996, 40098.797036088894, 40266.59733402665, 40965.0, 41437.792811035906, 41463.75608731743, 41469.792651036776, 41527.37708934368, 8082.999999999985, 9671.0, 9685.370450920704, 9695.951520242388, 9719.979402162777, 8678.088800675932, 8861.0, 8868.33487488441, 8999.775005624846, 9010.414323069012, 11738.7652246955, 11949.522019119226, 11968.581099661513, 12212.267263964146, 12223.69440763979, 11835.467403966843, 11995.820062699066, 12007.159498835084, 12027.879721202851, 12034.217775844585, 8556.5293908835, 8772.166644168794, 11671.824922626167, 11747.765044699143, 11749.588764393206, 38546.22907541862, 39164.412533812014, 39185.80407097975, 40751.79624101861, 40830.59169408298, 3192.9680703192903, 3386.5766779152605, 3414.726821854246, 3862.517185351831, 3898.571157172709, 28917.132486025454, 28945.131646050653, 30302.0, 30734.846325768453, 31113.688863111533, 3225.12921511193, 3244.9675503244903, 3262.9884735732, 3263.3962716897213, 3360.5463262459743, 517690.0, 520193.0, 521132.0, 536658.0, 616246.8375316234, 47892.76053619779, 55664.443355566735, 55861.44138558643, 56149.0, 59282.0, 60003.099953500736, 60267.0, 60280.09579856306, 60298.0, 60303.69848150819, 15757.842421575866, 15974.680506389806, 15992.520224393287, 16000.519984400487, 16010.759838602431, 12486.875131248753, 12811.743765124646, 12813.231206127475, 12814.0, 12832.871671283168, 13269.867301326864, 13586.660333491543, 15030.774538381933, 15032.549023529093, 15182.0, 7178.641067946582, 7227.096612923385, 7290.4896657233485, 7310.817229569197, 7339.7064117435775, 871.3900269811157, 951.8286708392417, 1013.2299452416216, 1026.30211456209, 1058.6136060338076, 29443.558346624817, 29677.961271355398, 29924.551131733042, 30298.69701303003, 30344.393112137634, 939.1500691873865, 1009.0918173643779, 1009.9747506312254, 1076.5370890517154, 1137.0051205195455, 12227.69430764238, 13146.934265328613, 15222.238888055554, 15543.922280388526, 15746.606334841721, 676753.0, 682086.0, 682495.0, 683434.0, 684263.0, 48532.0, 49204.34150072716, 54979.725101374235, 56598.0, 56740.71629641826, 1354.9661258468618, 1358.2529608715167, 1375.848656647768, 1375.9587212383644, 1376.1399125546534, 29899.850500747358, 31051.223719407197, 31137.37725245437, 31238.750449981748, 31949.0, 47156.29265561088, 47609.0, 47671.76164119157, 47673.52326476691, 47745.28382074341, 345591.0, 402610.0, 407911.0, 412152.0, 412283.0, 24962.37594060163, 25257.873710631327, 25269.87365063163, 25321.0, 25332.11337603249, 45496.0, 45523.41666088227, 45607.77196113998, 45758.313625296316, 45914.85212869571, 29653.0, 36665.0, 38096.80951595224, 38124.61875381211, 39111.804440978754, 36770.89687309385, 37442.43836342511, 37461.94263774356, 37685.86942391733, 38560.0, 36844.81577592202, 37409.0, 37610.8119459401, 37657.2468550622, 37724.43413348857, 31996.48038715786, 32185.517217241293, 32896.83551582227, 33250.501242480896, 33621.49567756535, 21262.78737212608, 25174.0, 25217.621735673612, 25569.872150639127, 25582.488350233263], "value": 19562.766666041123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.21541286051394, 364.3205421888178, 373.4230613701831, 374.5655040153422, 379.0523690773067, 14959.700805983888, 15337.0, 16205.756913646275, 20821.27125550606, 21317.253896113638, 20383.082761275742, 20741.274055408063, 21057.789422105776, 21276.0, 21477.14091436341, 5948.583599148062, 5963.254593175842, 6276.215473065867, 6276.623402595859, 6283.340249273829, 5431.402545719968, 5774.422557744213, 6309.053641953721, 6313.084602732601, 6315.273743519485, 3995.9200815983663, 4080.4083407905837, 5613.915791263134, 6182.969085154568, 6253.43719065284, 6040.154378387029, 6219.844503887393, 6283.5287353448675, 6287.591306565081, 6295.590786598879, 6099.0, 6101.877962440726, 6103.328633850273, 6108.480779133779, 6112.602680825732, 12923.22460652364, 12967.870321296761, 13032.0, 13084.934575327063, 13245.271510066943, 2166.4367264511184, 2194.484296190394, 2199.549092436047, 2218.9334319970426, 2934.2664333916523, 9847.015298470096, 9989.950050249776, 10100.24248181382, 10459.954004599555, 10489.527971241236, 1833.4316361927845, 1843.6220574782137, 1870.1116969439543, 1876.1557299215272, 2004.4888553418784, 126044.0, 136194.27611447716, 137774.0, 138126.0, 141656.2917185428, 11220.719482012852, 11438.370889600985, 11605.6518304451, 11649.184557080924, 11784.823227651592, 14710.41158353654, 14719.0, 14724.263786810616, 14730.55808325752, 14746.926265368604, 8515.829683406297, 8576.571171441403, 8589.65641374338, 8617.267532259702, 8751.737447876574, 8590.312774977987, 8608.053114157437, 8634.050254472004, 8746.387752857367, 8746.431481953652, 4504.549545045469, 4507.616852567503, 4515.300128480091, 4522.208613492626, 4612.800671825283, 1861.1252711225702, 1897.0514742628686, 1907.5994041251492, 1910.4746194796264, 1910.92356305749, 867.8915135608049, 914.5792935249726, 928.962841486333, 968.4479846487435, 984.7341217871135, 20142.892140932097, 21783.36860722791, 21831.431718830194, 21854.89072554627, 21949.78050219509, 932.8507438809758, 945.6028468043438, 960.519740129935, 981.0225964198623, 982.6953644370268, 10463.895361046445, 11334.603288885015, 11354.54581816718, 11384.20310578268, 11501.827472587918, 632987.0, 636938.0, 638535.0, 643018.0, 648226.0, 109523.90476095297, 111772.0, 123417.0, 124954.0, 139519.90720139205, 744.3301029073876, 984.7390441532999, 1016.5628779624684, 1017.4099022566893, 1018.2363227579316, 18952.71570926465, 19489.0, 19529.902350488155, 19668.0, 19698.90150549238, 57155.14267286077, 57331.42668573428, 58541.70729146327, 58930.11604825845, 59386.70306648439, 75400.62299688686, 84616.15383846083, 84669.57665211635, 85215.0, 86656.83357916103, 7904.156986309685, 8019.558924259221, 8072.354211663171, 8443.113473085483, 8456.66173353059, 9327.533623318943, 12571.245725256515, 13226.156376379126, 13310.667233318856, 13572.864271357555, 9280.0, 11264.831027534758, 11441.828372574251, 11599.478023489131, 11613.30320180792, 11187.534117413334, 11201.551937922392, 11309.943450282695, 11366.147538934778, 11730.12024098213, 11503.884961150281, 11551.191416600757, 11709.0, 11734.413279335828, 11953.521859125885, 7881.857130716129, 8020.719274825353, 8258.463199892229, 8359.247667709935, 8428.283595894418, 10190.286679932333, 11319.09447244235, 11447.713807154554, 11531.8270225945, 11595.13036522281], "value": 9540.716270397666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.7930729351535, 1544.3282172255067, 1720.7676963609908, 1870.7100399438075, 1888.291890541047, 8477.703280385187, 9041.502717350542, 9045.954770226139, 9050.45697258165, 9080.682176123837, 7844.764657060283, 8063.475874068182, 8087.191280871924, 8563.229309362156, 8794.604242809073, 2377.7027871516016, 2419.2016634510655, 2419.5523828091773, 2422.8667423291713, 2424.8423852449623, 2389.6176611742126, 2395.3891757601787, 2402.4714562796157, 2428.502157057808, 2430.368104292888, 2001.9689859722255, 2030.2893987104544, 2395.3532546212514, 2397.4965257295903, 2399.664047033417, 1996.8901710405921, 2368.325027367192, 2386.4391867911027, 2392.485615592656, 2399.2802159352213, 2382.3805810489225, 2387.940301492459, 2395.2694428199393, 2395.5208958208254, 2395.5448464791634, 8893.822123557493, 8917.955410222972, 8988.820223595492, 8994.235489983359, 9012.369134160612, 5286.497782710637, 5449.073657478199, 5451.291332126838, 5457.508824205801, 5468.589855760833, 3504.0013596125236, 3590.299891521154, 3706.2031663192274, 3722.274156539476, 3724.1992971511254, 1103.9779204415868, 1105.729096371386, 1108.2519299472904, 1130.3387518301804, 1130.7455822439968, 8669.0, 11923.582674606347, 11939.462724177347, 11939.985101266402, 12476.563320283747, 4280.614744672932, 4392.2752745797225, 4513.50351461339, 4642.303654451859, 4889.193283108319, 9486.478243696663, 10110.949445252727, 10113.342632728849, 10124.291299609104, 10125.64560240388, 5411.594130440233, 5419.620626556103, 5422.6475279106735, 5426.701531415731, 5428.864278393072, 4456.22016147173, 4485.910281794346, 4902.240152776325, 4922.310876477296, 4952.133376659142, 4000.7999600019884, 4012.117334186474, 4086.468759061303, 4116.135611521554, 4130.524989626171, 1295.242283264301, 1305.484333688188, 1305.4843336882068, 1317.466426097432, 1319.511780641169, 912.9680461183826, 918.8695721203376, 928.6842473558887, 930.7021753039098, 982.872226610536, 4905.877353066202, 5660.0, 5669.6314739541795, 6067.484263837535, 6223.0, 432.23494414885477, 440.0025765916619, 444.87098741365287, 449.6200710399707, 463.9396878405786, 3984.183242435294, 3994.0, 4000.4799376080923, 4048.5344185418467, 4059.167870586523, 10474.266801323834, 10779.02988731018, 10848.294860834021, 10867.076298514714, 10899.618513351994, 10729.141668666489, 10748.570057197625, 10790.51442685081, 10801.459927003618, 10810.135189184846, 7828.217178282126, 8115.513069215866, 8182.0, 8203.671853125808, 8217.972753405824, 5975.611585246945, 6010.699465026643, 6038.818835434944, 6052.760478622938, 6111.511079113571, 9991.950040250043, 10269.0, 10272.691819245434, 10278.229132815219, 10291.485425728833, 10025.949870250603, 10076.244281678757, 10305.227107967083, 10393.16854651611, 10467.319624224401, 6484.254310754323, 7054.118235220598, 7295.708171673074, 7484.663190156347, 7547.547147171187, 8424.0, 8557.700480483154, 8562.700305489527, 8562.957185214034, 8566.614502347535, 6266.968665156645, 7443.851122977402, 7585.772426827204, 7616.8476630468185, 7698.153203147537, 7431.145418276968, 7466.8506629866015, 7499.475036747375, 7513.774586762406, 7642.388608911385, 6961.58230506151, 7128.786136415916, 7133.714651414093, 7139.535930164523, 7143.749968751069, 5002.499750024968, 5059.974700126476, 5069.695818250917, 5099.490050994871, 5175.0, 5047.596192304533, 5052.8484145475695, 5181.53366197044, 5191.948080519146, 5222.686638801684], "value": 4541.428447544201, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.67764830455565, 304.22878004259223, 311.270071681906, 314.42460297655293, 316.92235402326435, 5216.052930094504, 5452.263944367519, 5504.889902201959, 5521.668699878005, 5535.924028489317, 5282.366116066068, 5345.599080068991, 5376.03774622263, 5403.891922161564, 5453.2092846537325, 3314.535964964901, 3529.470579413096, 4087.7093939378788, 4146.896327591804, 4150.564190759972, 3838.6545210931013, 4085.12169883475, 4167.958320416802, 4180.811863466151, 4191.874243772677, 3558.3594952908466, 4022.45696830927, 4047.5547689754103, 4077.938830917539, 4098.52866920305, 4078.877633670995, 4091.2226676931286, 4091.365838295069, 4095.3242714952, 4104.384342348641, 2939.617849679549, 3118.7836743669986, 3135.8902438414775, 3284.770066095374, 3331.4503106987318, 4579.702319349231, 4674.532546745332, 5069.518395752398, 5257.737113144328, 5272.576404370837, 3741.756785808941, 4311.461067366579, 4661.6969896956925, 4672.742999135046, 4700.600448961808, 5331.293985924506, 5712.6001179917, 5735.627184233012, 5755.194272801811, 5761.510271626917, 3526.982365088184, 3835.5972622874474, 3839.214765134226, 3853.0, 3860.8148277671035, 4928.728919909404, 6022.337542870281, 6086.939130608682, 6112.877742445171, 6118.969405152946, 3537.6816086552335, 3714.888553343404, 3797.905052373713, 3915.647591716759, 4058.8690937257584, 3485.233248685285, 4097.672186225095, 4128.545859955402, 4134.545200028055, 4149.937750933738, 4761.262004389325, 4785.784639691222, 4795.160846851787, 4803.927941080817, 4820.180569303227, 5569.164625306236, 5791.739371728282, 5809.070548712186, 5817.38917413674, 5854.677992710442, 1209.8548174218975, 1389.2703584037938, 1411.2802470739996, 1416.6175132714109, 1423.1603354021177, 737.2821326309686, 825.7068740597122, 864.3085531574841, 867.3321542412307, 872.1932212703224, 3933.704972127102, 4433.46798384196, 4501.009777848868, 4512.2329204035395, 4537.750423726727, 4295.914081718348, 4344.827586206897, 4401.911961760747, 4458.08609235106, 4579.450465944042, 3592.9101772455374, 4210.305299625588, 4396.384506169139, 4490.7754612269255, 4519.570640789119, 2211.1818627108073, 2420.5400973814917, 2602.856842873622, 2624.9868750656506, 2636.49906517761, 4591.47198072226, 5081.949180508148, 5125.359330083739, 5142.434332223453, 5237.559671090405, 4813.446453657874, 4882.803713090316, 5010.444673216686, 5026.421961474477, 5129.64092513528, 3959.742616729903, 4447.421835161408, 4978.278149668277, 5065.797368105308, 5171.043356978971, 4866.537678920497, 4895.4370247422, 4906.533879281463, 4906.803727850989, 4916.434610019751, 4207.1375368050085, 4346.9130617386845, 4842.8619274471175, 4875.0493653737185, 4921.409430868319, 4526.886827829199, 4545.795439205178, 4659.0, 5056.62075344358, 5103.2491119026745, 3487.459443786217, 3787.5833658298116, 3898.6101389860787, 3927.4501569780823, 3928.66606338453, 5178.042062218502, 5232.659877108128, 5862.765489380377, 5867.413258674099, 5964.642121472725, 5009.5491405773655, 5611.963988988401, 5745.971270143623, 5764.394738552392, 5787.508061814793, 4544.18204723153, 5119.846404607868, 5152.536271735562, 5272.78908843642, 5693.829185124453, 5161.225816127611, 5591.4688104629995, 5660.867566676432, 5677.9495793278375, 5684.459976302244, 4990.0, 5362.176859867664, 5464.278752193047, 5530.695811730233, 5725.08398656213, 5540.390557038803, 5573.331200255995, 5583.41374155724, 5586.804461843816, 5607.719614019201], "value": 3936.061526165549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4726785785665, 784.580249566482, 784.7449578886864, 789.7235967411407, 795.5743677132735, 14997.100173989555, 16053.438129665436, 16098.114603696822, 16217.108059056747, 16217.75673364899, 14416.92791536041, 14578.416863325481, 14591.854081459182, 14623.122612643248, 14639.341229644664, 679.6397909108156, 706.6608028146493, 835.2566216067675, 841.1798496465958, 863.2619110660389, 811.059171361221, 812.0539571399313, 821.9876701849447, 855.4097672605914, 857.5412154497345, 708.1926603671818, 902.8961669408036, 903.6520939438298, 905.7463910105181, 906.8050369170627, 725.9128904531437, 886.4991279926853, 900.0324651000136, 901.5357091098024, 911.2436677557678, 674.6289540752566, 675.4056430341317, 675.5710124071201, 676.3338111959715, 678.8642271545662, 15055.322510487054, 15060.246987650573, 15073.773893391608, 15077.0, 15077.396904123822, 13691.726165476635, 13928.233947132903, 14021.9483538735, 14118.0, 14224.217668028254, 12540.623781286577, 12804.743905121846, 12972.610821675271, 13015.219086854819, 13349.132306400053, 4509.571590698878, 4518.367428560005, 4548.612673134692, 4566.1552612766745, 4712.387389639325, 122706.77293227043, 128001.0, 128146.35926820399, 129181.0, 131305.0, 10844.295120817122, 11016.283941543774, 11149.331040137618, 11167.0, 11290.435478226056, 21905.0, 22063.66904496434, 22116.115355385606, 22122.557548848934, 22132.0, 7041.767690654115, 7724.613769311624, 7843.647035883285, 7989.520628762293, 8115.594220288962, 4302.892427689333, 4359.67302452311, 4381.277089280233, 4446.421965144576, 4546.909061818745, 3458.3256265028076, 3605.3330133924783, 3606.513120728668, 3606.765560238576, 3609.1698909251018, 642.502060902804, 659.970301336441, 666.1839246922578, 667.8630880669451, 671.785028790792, 580.5065694160014, 606.1967892542399, 615.9744026196333, 622.2244275188004, 629.4052120745943, 9075.3364796364, 9080.228180604723, 9086.772830679285, 9105.590248438835, 9189.448633082036, 576.4840467781312, 609.1532769450467, 627.5889292513411, 628.1300398947491, 632.5445679111033, 4464.620507256855, 4466.798994045275, 4493.73037617744, 4529.116822219636, 4566.246569316026, 106281.0, 128132.0, 149892.0, 168025.0, 179794.0, 103647.0, 133731.0, 137544.0, 138860.0, 145200.0, 113714.0, 117527.41236293934, 125121.74878251283, 129179.31155163213, 129751.0, 8451.197136272045, 8685.478871267744, 8854.867176992222, 8905.332100092648, 8960.417572857743, 67603.30991725049, 69386.30613694001, 69483.65258173677, 70283.94574081291, 70414.0, 101397.49301253447, 103264.0, 106459.46770266099, 107997.3800392979, 109561.45219273852, 10751.516181771683, 10760.3543787373, 11046.944765276123, 11471.655850324503, 11530.365829879102, 11964.162508624313, 12276.938615306866, 12600.0, 12831.0, 12883.742325153256, 10973.341599504056, 11802.055835533309, 11817.645470635895, 11827.791639590701, 12164.452599633214, 12012.33932133706, 12187.268763874195, 12208.938955305166, 12533.686657833627, 12572.0, 11629.418529073682, 11903.047756179312, 11943.402829858645, 12054.638360849189, 12337.50649973991, 9365.859512107187, 10035.0, 10050.497475126069, 10909.563617455531, 11804.542821183686, 11662.300261984308, 11803.350815705218, 11864.76270474603, 11920.523179073087, 11929.701757456132], "value": 7805.844983810085, "unit": "score"}], "name": "dromaeo_css", "value": 7283.8304469408495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 115.0, 115.0, 116.0, 113.0, 122.0, 170.0, 152.0], "value": 124.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 110.0, 141.0, 113.0, 109.0, 109.0, 106.0, 137.0, 109.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 184.0, 184.0, 183.0, 182.0, 181.0, 183.0, 182.0, 183.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 88.0, 60.0, 59.0, 60.0, 58.0, 83.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 70.0, 67.0, 68.0, 92.0, 70.0, 68.0, 89.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 88.0, 88.0, 85.0, 88.0, 86.0, 89.0, 84.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 101.0, 149.0, 138.0, 93.0, 94.0, 94.0], "value": 104.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 86.0, 83.0, 85.0, 85.0, 83.0, 85.0, 87.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 57.0, 55.0, 62.0, 79.0, 89.0, 89.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 75.0, 76.0, 76.0, 72.0, 69.0, 69.0, 69.0, 71.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 101.0, 103.0, 83.0, 82.0, 85.0, 82.0, 83.0, 83.0, 100.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 151.0, 151.0, 137.0, 140.0, 140.0, 141.0, 176.0, 163.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 164.0, 163.0, 164.0, 163.0, 163.0, 162.0, 166.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 86.0, 85.0, 87.0, 83.0, 85.0, 75.0, 67.0], "value": 77.4, "unit": "score"}], "name": "kraken", "value": 1459.1, "alertThreshold": 2.0}]} 17:04:23 INFO - Return code: 0 17:04:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:04:23 INFO - # TBPL SUCCESS # 17:04:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:04:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:04:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:04:23 INFO - 2016-10-08 17:04:23.793 screenresolution[1676:10962] starting screenresolution argv=screenresolution get 17:04:23 INFO - 2016-10-08 17:04:23.796 screenresolution[1676:10962] Display 0: 1600x1200x32@60 17:04:23 INFO - 2016-10-08 17:04:23.802 screenresolution[1677:10966] starting screenresolution argv=screenresolution list 17:04:23 INFO - Available Modes on Display 0 17:04:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:04:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:04:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:04:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:04:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:04:24 INFO - Intel Iris: 17:04:24 INFO - Chipset Model: Intel Iris 17:04:24 INFO - Type: GPU 17:04:24 INFO - Bus: Built-In 17:04:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:04:24 INFO - Vendor: Intel (0x8086) 17:04:24 INFO - Device ID: 0x0a2e 17:04:24 INFO - Revision ID: 0x0009 17:04:24 INFO - Displays: 17:04:24 INFO - Display: 17:04:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:04:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:04:24 INFO - Display Serial Number: 1600x1200 60 17:04:24 INFO - Main Display: Yes 17:04:24 INFO - Mirror: Off 17:04:24 INFO - Online: Yes 17:04:24 INFO - Rotation: Supported 17:04:24 INFO - Return code: 0 17:04:24 INFO - Running post-action listener: _resource_record_post_action 17:04:24 INFO - [mozharness: 2016-10-09 00:04:24.030664Z] Finished run-tests step (success) 17:04:24 INFO - Running post-run listener: _resource_record_post_run 17:04:24 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32001024; Write bytes: 663738880; Read time: 196; Write time: 1883 17:04:24 INFO - TinderboxPrint: CPU usage
53.4% 17:04:24 INFO - TinderboxPrint: I/O read bytes / time
32,001,024 / 196 17:04:24 INFO - TinderboxPrint: I/O write bytes / time
663,738,880 / 1,883 17:04:24 INFO - TinderboxPrint: CPU idle
2,254.8 (46.6%) 17:04:24 INFO - TinderboxPrint: CPU system
965.6 (20.0%) 17:04:24 INFO - TinderboxPrint: CPU user
1,617.2 (33.4%) 17:04:24 INFO - TinderboxPrint: Swap in / out
391,696,384 / 0 17:04:24 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358279680; Write bytes: 355579392; Read time: 27404; Write time: 741 17:04:24 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30133248; Write bytes: 297137152; Read time: 182; Write time: 1105 17:04:24 INFO - Running post-run listener: _upload_blobber_files 17:04:24 INFO - Blob upload gear active. 17:04:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:24 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 17:04:24 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'] 17:04:24 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 17:04:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:04:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:28 INFO - (blobuploader) - INFO - Done attempting. 17:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:28 INFO - (blobuploader) - INFO - Done attempting. 17:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:31 INFO - (blobuploader) - INFO - Done attempting. 17:04:31 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:31 INFO - Return code: 0 17:04:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0565fa9636c090e5f4657574cfc8ad86901ca40e76cf438f52e989d774131f61155409106b52d303ae64e4a0ca8dfd9a5a610beed6b7ccb12e78947b966de206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da7d60a2f056306dae7f640849b19f1eb4f9d9c1ec48e8e2470cba3722b8a9231da1b24c01fdfdf047eb29260d910f60d94207ad6b9e8b89063685dbc6633ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2350311292a94823e4250bf87bb06d5d0313d6b54242977786a68d0963e50d5513b93cba070d8d73b4ac2dcb87ff88a0346e55981e07fca99a0237443e453045"} 17:04:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:31 INFO - Contents: 17:04:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0565fa9636c090e5f4657574cfc8ad86901ca40e76cf438f52e989d774131f61155409106b52d303ae64e4a0ca8dfd9a5a610beed6b7ccb12e78947b966de206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da7d60a2f056306dae7f640849b19f1eb4f9d9c1ec48e8e2470cba3722b8a9231da1b24c01fdfdf047eb29260d910f60d94207ad6b9e8b89063685dbc6633ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2350311292a94823e4250bf87bb06d5d0313d6b54242977786a68d0963e50d5513b93cba070d8d73b4ac2dcb87ff88a0346e55981e07fca99a0237443e453045"} 17:04:31 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:31 INFO - Copying logs to upload dir... 17:04:31 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.984145 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-08 17:04:31.524245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 17:04:31.528174) ========= 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.3hZZoKktTM/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.Wmamrb2UdT/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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/0565fa9636c090e5f4657574cfc8ad86901ca40e76cf438f52e989d774131f61155409106b52d303ae64e4a0ca8dfd9a5a610beed6b7ccb12e78947b966de206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da7d60a2f056306dae7f640849b19f1eb4f9d9c1ec48e8e2470cba3722b8a9231da1b24c01fdfdf047eb29260d910f60d94207ad6b9e8b89063685dbc6633ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2350311292a94823e4250bf87bb06d5d0313d6b54242977786a68d0963e50d5513b93cba070d8d73b4ac2dcb87ff88a0346e55981e07fca99a0237443e453045"} build_url:https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/ZFwWEk9UQNCvoNX0CpSMGQ/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/0565fa9636c090e5f4657574cfc8ad86901ca40e76cf438f52e989d774131f61155409106b52d303ae64e4a0ca8dfd9a5a610beed6b7ccb12e78947b966de206", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0da7d60a2f056306dae7f640849b19f1eb4f9d9c1ec48e8e2470cba3722b8a9231da1b24c01fdfdf047eb29260d910f60d94207ad6b9e8b89063685dbc6633ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2350311292a94823e4250bf87bb06d5d0313d6b54242977786a68d0963e50d5513b93cba070d8d73b4ac2dcb87ff88a0346e55981e07fca99a0237443e453045"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 17:04:31.560035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 17:04:31.560331) ========= 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.3hZZoKktTM/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.Wmamrb2UdT/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 17:04:31.608595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 17:04:31.608919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 17:04:31.609224) ========= ========= Total master_lag: 0.33 =========