builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1478517613.0 results: success (0) buildid: 20161107004002 builduid: 0af2c263a59f4b849a799d2d7db0b331 revision: 8027a7b723c9db7254bdb0bea3bc8937220daa7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.004664) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.012040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.012343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.037292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.037575) ========= 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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-11-07 03:20:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.11M=0.001s 2016-11-07 03:20:13 (9.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.138062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.138385) ========= 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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.025665 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:13.186570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-07 03:20:13.186944) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8027a7b723c9db7254bdb0bea3bc8937220daa7e --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 8027a7b723c9db7254bdb0bea3bc8937220daa7e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nKFfNzJB7z/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.FBoZHJlz1D/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-11-07 03:20:13,263 truncating revision to first 12 chars 2016-11-07 03:20:13,263 Setting DEBUG logging. 2016-11-07 03:20:13,263 attempt 1/10 2016-11-07 03:20:13,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8027a7b723c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 03:20:15,174 unpacking tar archive at: mozilla-aurora-8027a7b723c9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.159968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-07 03:20:15.369307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:15.369830) ========= script_repo_revision: 8027a7b723c9db7254bdb0bea3bc8937220daa7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:15.370313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:15.370662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 03:20:15.389365) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-07 03:20:15.389695) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nKFfNzJB7z/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.FBoZHJlz1D/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:20:15 INFO - MultiFileLogger online at 20161107 03:20:15 in /builds/slave/test 03:20:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:20:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:15 INFO - {'append_to_log': False, 03:20:15 INFO - 'base_work_dir': '/builds/slave/test', 03:20:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:20:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:15 INFO - 'branch': 'Mozilla-Aurora', 03:20:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:15 INFO - 'config_files': ('talos/mac_config.py',), 03:20:15 INFO - 'default_actions': ('clobber', 03:20:15 INFO - 'read-buildbot-config', 03:20:15 INFO - 'download-and-extract', 03:20:15 INFO - 'populate-webroot', 03:20:15 INFO - 'create-virtualenv', 03:20:15 INFO - 'install', 03:20:15 INFO - 'run-tests'), 03:20:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:15 INFO - 'download_minidump_stackwalk': True, 03:20:15 INFO - 'download_symbols': 'ondemand', 03:20:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:15 INFO - 'installer_path': 'installer.exe', 03:20:15 INFO - 'log_level': 'info', 03:20:15 INFO - 'log_name': 'talos', 03:20:15 INFO - 'log_to_console': True, 03:20:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:20:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:20:15 INFO - 'opt_config_files': (), 03:20:15 INFO - 'pip_index': False, 03:20:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:15 INFO - 'cmd': ('bash', 03:20:15 INFO - '-c', 03:20:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:15 INFO - 'enabled': True, 03:20:15 INFO - 'halt_on_failure': False, 03:20:15 INFO - 'name': 'check_screen_resolution'},), 03:20:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:15 INFO - 'cmd': ('bash', 03:20:15 INFO - '-c', 03:20:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:15 INFO - 'enabled': True, 03:20:15 INFO - 'halt_on_failure': False, 03:20:15 INFO - 'name': 'check_screen_resolution'},), 03:20:15 INFO - 'run_cmd_checks_enabled': True, 03:20:15 INFO - 'sps_profile': False, 03:20:15 INFO - 'sps_profile_interval': 0, 03:20:15 INFO - 'suite': 'dromaeojs', 03:20:15 INFO - 'system_bits': '32', 03:20:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:15 INFO - 'title': 't-yosemite-r7-0030', 03:20:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:15 INFO - 'use_talos_json': True, 03:20:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:15 INFO - 'work_dir': 'build'} 03:20:15 INFO - [mozharness: 2016-11-07 11:20:15.586753Z] Running clobber step. 03:20:15 INFO - Running pre-action listener: _resource_record_pre_action 03:20:15 INFO - Running main action method: clobber 03:20:15 INFO - rmtree: /builds/slave/test/build 03:20:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:17 INFO - Running post-action listener: _resource_record_post_action 03:20:17 INFO - [mozharness: 2016-11-07 11:20:17.954070Z] Finished clobber step (success) 03:20:17 INFO - [mozharness: 2016-11-07 11:20:17.954224Z] Running read-buildbot-config step. 03:20:17 INFO - Running pre-action listener: _resource_record_pre_action 03:20:17 INFO - Running main action method: read_buildbot_config 03:20:17 INFO - Using buildbot properties: 03:20:17 INFO - { 03:20:17 INFO - "project": "", 03:20:17 INFO - "product": "firefox", 03:20:17 INFO - "script_repo_revision": "production", 03:20:17 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:20:17 INFO - "repository": "", 03:20:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:20:17 INFO - "buildid": "20161107004002", 03:20:17 INFO - "stage_platform": "macosx64", 03:20:17 INFO - "basedir": "/builds/slave/test", 03:20:17 INFO - "nightly_build": "True", 03:20:17 INFO - "buildnumber": 22, 03:20:17 INFO - "slavename": "t-yosemite-r7-0030", 03:20:17 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:20:17 INFO - "platform": "yosemite_r7", 03:20:17 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:20:17 INFO - "branch": "mozilla-aurora", 03:20:17 INFO - "repo_path": "releases/mozilla-aurora", 03:20:17 INFO - "revision": "8027a7b723c9db7254bdb0bea3bc8937220daa7e", 03:20:17 INFO - "pgo_build": "False", 03:20:17 INFO - "builduid": "0af2c263a59f4b849a799d2d7db0b331", 03:20:17 INFO - "slavebuilddir": "test" 03:20:17 INFO - } 03:20:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:20:17 INFO - Running post-action listener: _resource_record_post_action 03:20:17 INFO - [mozharness: 2016-11-07 11:20:17.957681Z] Finished read-buildbot-config step (success) 03:20:17 INFO - [mozharness: 2016-11-07 11:20:17.957813Z] Running download-and-extract step. 03:20:17 INFO - Running pre-action listener: _resource_record_pre_action 03:20:17 INFO - Running main action method: download_and_extract 03:20:17 INFO - mkdir: /builds/slave/test/build/tests 03:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:17 INFO - trying https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:20:17 INFO - Downloading https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/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 03:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/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 03:20:19 INFO - Downloaded 1199 bytes. 03:20:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:20:19 INFO - Using the following test package requirements: 03:20:19 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:20:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:20:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:20:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'jsshell-mac.zip'], 03:20:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:20:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:20:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:20:19 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:20:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:20:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:20:19 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:20:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:20:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:20:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:20:19 INFO - Fetch https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:20:19 INFO - Expected file size: 16421607 03:20:27 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 03:20:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:20:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:20:27 INFO - Fetch https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:20:27 INFO - Expected file size: 16421607 03:20:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:20:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:20:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:20:35 INFO - Expected file size: 14414089 03:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:35 INFO - trying https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:20:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/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 03:20:38 INFO - Downloaded 115534854 bytes. 03:20:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:20:38 INFO - mkdir: /builds/slave/test/properties 03:20:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:38 INFO - Contents: 03:20:38 INFO - build_url:https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:20:39 INFO - Running post-action listener: _resource_record_post_action 03:20:39 INFO - Running post-action listener: set_extra_try_arguments 03:20:39 INFO - [mozharness: 2016-11-07 11:20:39.366765Z] Finished download-and-extract step (success) 03:20:39 INFO - [mozharness: 2016-11-07 11:20:39.366919Z] Running populate-webroot step. 03:20:39 INFO - Running pre-action listener: _resource_record_pre_action 03:20:39 INFO - Running main action method: populate_webroot 03:20:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:20:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:20:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:20:39 INFO - '--tppagecycles', 03:20:39 INFO - '7'], 03:20:39 INFO - 'tests': ['tsvgm']}}, 03:20:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:20:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:20:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['damp', 'tps']}, 03:20:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'tests': ['damp', 'tps']}, 03:20:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['dromaeo_dom']}, 03:20:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['basic_compositor_video']}, 03:20:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:20:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['a11yr', 03:20:39 INFO - 'ts_paint', 03:20:39 INFO - 'tpaint', 03:20:39 INFO - 'sessionrestore', 03:20:39 INFO - 'sessionrestore_no_auto_restore', 03:20:39 INFO - 'tabpaint']}, 03:20:39 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:39 INFO - 'ts_paint', 03:20:39 INFO - 'tpaint', 03:20:39 INFO - 'sessionrestore', 03:20:39 INFO - 'sessionrestore_no_auto_restore', 03:20:39 INFO - 'tabpaint']}, 03:20:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:20:39 INFO - 'ts_paint', 03:20:39 INFO - 'tpaint', 03:20:39 INFO - 'sessionrestore', 03:20:39 INFO - 'sessionrestore_no_auto_restore', 03:20:39 INFO - 'tabpaint']}, 03:20:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:20:39 INFO - 'ts_paint', 03:20:39 INFO - 'tpaint', 03:20:39 INFO - 'sessionrestore', 03:20:39 INFO - 'sessionrestore_no_auto_restore', 03:20:39 INFO - 'tabpaint']}, 03:20:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['a11yr', 03:20:39 INFO - 'ts_paint', 03:20:39 INFO - 'tpaint', 03:20:39 INFO - 'sessionrestore', 03:20:39 INFO - 'sessionrestore_no_auto_restore', 03:20:39 INFO - 'tabpaint']}, 03:20:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['a11yr', 03:20:39 INFO - 'ts_paint', 03:20:39 INFO - 'tpaint', 03:20:39 INFO - 'sessionrestore', 03:20:39 INFO - 'sessionrestore_no_auto_restore', 03:20:39 INFO - 'tabpaint']}, 03:20:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['tsvgx', 03:20:39 INFO - 'tsvgr_opacity', 03:20:39 INFO - 'tart', 03:20:39 INFO - 'tscrollx', 03:20:39 INFO - 'cart']}, 03:20:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:39 INFO - 'tsvgr_opacity', 03:20:39 INFO - 'tart', 03:20:39 INFO - 'tscrollx', 03:20:39 INFO - 'cart']}, 03:20:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'talos_options': ['--disable-e10s'], 03:20:39 INFO - 'tests': ['tp5o']}, 03:20:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'tests': ['tp5o']}, 03:20:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'talos_options': ['--disable-e10s', 03:20:39 INFO - '--xperf_path', 03:20:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:39 INFO - 'tests': ['tp5n']}, 03:20:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:39 INFO - 'talos_options': ['--xperf_path', 03:20:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:39 INFO - 'tests': ['tp5n']}}, 03:20:39 INFO - 'talos.zip': {'path': '', 03:20:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:20:39 INFO - Running post-action listener: _resource_record_post_action 03:20:39 INFO - [mozharness: 2016-11-07 11:20:39.385928Z] Finished populate-webroot step (success) 03:20:39 INFO - [mozharness: 2016-11-07 11:20:39.386039Z] Running create-virtualenv step. 03:20:39 INFO - Running pre-action listener: _resource_record_pre_action 03:20:39 INFO - Running main action method: create_virtualenv 03:20:39 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:20:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:39 INFO - Using real prefix '/tools/python27' 03:20:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:40 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:43 INFO - Installing pip.................done. 03:20:43 INFO - Return code: 0 03:20:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:43 INFO - 'HOME': '/Users/cltbld', 03:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:43 INFO - 'LOGNAME': 'cltbld', 03:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:43 INFO - 'MOZ_NO_REMOTE': '1', 03:20:43 INFO - 'NO_EM_RESTART': '1', 03:20:43 INFO - 'PAGER': '/bin/cat', 03:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:43 INFO - 'PWD': '/builds/slave/test', 03:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:43 INFO - 'SHELL': '/bin/bash', 03:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:43 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:43 INFO - 'USER': 'cltbld', 03:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:43 INFO - 'XPC_FLAGS': '0x0', 03:20:43 INFO - 'XPC_SERVICE_NAME': '0', 03:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:20:43 INFO - Cleaning up... 03:20:43 INFO - Return code: 0 03:20:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:43 INFO - 'HOME': '/Users/cltbld', 03:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:43 INFO - 'LOGNAME': 'cltbld', 03:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:43 INFO - 'MOZ_NO_REMOTE': '1', 03:20:43 INFO - 'NO_EM_RESTART': '1', 03:20:43 INFO - 'PAGER': '/bin/cat', 03:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:43 INFO - 'PWD': '/builds/slave/test', 03:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:43 INFO - 'SHELL': '/bin/bash', 03:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:43 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:43 INFO - 'USER': 'cltbld', 03:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:43 INFO - 'XPC_FLAGS': '0x0', 03:20:43 INFO - 'XPC_SERVICE_NAME': '0', 03:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:43 INFO - Downloading/unpacking psutil>=3.1.1 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:46 INFO - Installing collected packages: psutil 03:20:46 INFO - Running setup.py install for psutil 03:20:46 INFO - building 'psutil._psutil_osx' extension 03:20:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:20:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:20:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:20:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:20:47 INFO - building 'psutil._psutil_posix' extension 03:20:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:20:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:20:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:20:47 INFO - ^ 03:20:47 INFO - 1 warning generated. 03:20:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:47 INFO - Successfully installed psutil 03:20:47 INFO - Cleaning up... 03:20:47 INFO - Return code: 0 03:20:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20: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')]} 03:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:47 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:47 INFO - 'HOME': '/Users/cltbld', 03:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:47 INFO - 'LOGNAME': 'cltbld', 03:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:47 INFO - 'MOZ_NO_REMOTE': '1', 03:20:47 INFO - 'NO_EM_RESTART': '1', 03:20:47 INFO - 'PAGER': '/bin/cat', 03:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:47 INFO - 'PWD': '/builds/slave/test', 03:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:47 INFO - 'SHELL': '/bin/bash', 03:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:47 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:47 INFO - 'USER': 'cltbld', 03:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:47 INFO - 'XPC_FLAGS': '0x0', 03:20:47 INFO - 'XPC_SERVICE_NAME': '0', 03:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:50 INFO - Installing collected packages: mozsystemmonitor 03:20:50 INFO - Running setup.py install for mozsystemmonitor 03:20:50 INFO - Successfully installed mozsystemmonitor 03:20:50 INFO - Cleaning up... 03:20:50 INFO - Return code: 0 03:20:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:20:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:50 INFO - 'HOME': '/Users/cltbld', 03:20:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:50 INFO - 'LOGNAME': 'cltbld', 03:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:50 INFO - 'MOZ_NO_REMOTE': '1', 03:20:50 INFO - 'NO_EM_RESTART': '1', 03:20:50 INFO - 'PAGER': '/bin/cat', 03:20:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:50 INFO - 'PWD': '/builds/slave/test', 03:20:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:50 INFO - 'SHELL': '/bin/bash', 03:20:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:50 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:50 INFO - 'USER': 'cltbld', 03:20:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:50 INFO - 'XPC_FLAGS': '0x0', 03:20:50 INFO - 'XPC_SERVICE_NAME': '0', 03:20:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:54 INFO - warning: no files found matching '*.txt' 03:20:54 INFO - no previously-included directories found matching 'build' 03:20:54 INFO - no previously-included directories found matching 'dist' 03:20:54 INFO - no previously-included directories found matching '.git*' 03:20:54 INFO - Installing collected packages: jsonschema, functools32 03:20:54 INFO - Running setup.py install for functools32 03:20:54 INFO - warning: no files found matching '*.txt' 03:20:54 INFO - no previously-included directories found matching 'build' 03:20:54 INFO - no previously-included directories found matching 'dist' 03:20:54 INFO - no previously-included directories found matching '.git*' 03:20:54 INFO - Successfully installed jsonschema functools32 03:20:54 INFO - Cleaning up... 03:20:54 INFO - Return code: 0 03:20:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:54 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:54 INFO - 'HOME': '/Users/cltbld', 03:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:54 INFO - 'LOGNAME': 'cltbld', 03:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:54 INFO - 'MOZ_NO_REMOTE': '1', 03:20:54 INFO - 'NO_EM_RESTART': '1', 03:20:54 INFO - 'PAGER': '/bin/cat', 03:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:54 INFO - 'PWD': '/builds/slave/test', 03:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:54 INFO - 'SHELL': '/bin/bash', 03:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:54 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:54 INFO - 'USER': 'cltbld', 03:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:54 INFO - 'XPC_FLAGS': '0x0', 03:20:54 INFO - 'XPC_SERVICE_NAME': '0', 03:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:54 INFO - Cleaning up... 03:20:54 INFO - Return code: 0 03:20:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:54 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:20:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:54 INFO - 'HOME': '/Users/cltbld', 03:20:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:54 INFO - 'LOGNAME': 'cltbld', 03:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:54 INFO - 'MOZ_NO_REMOTE': '1', 03:20:54 INFO - 'NO_EM_RESTART': '1', 03:20:54 INFO - 'PAGER': '/bin/cat', 03:20:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:54 INFO - 'PWD': '/builds/slave/test', 03:20:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:54 INFO - 'SHELL': '/bin/bash', 03:20:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:54 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:54 INFO - 'USER': 'cltbld', 03:20:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:54 INFO - 'XPC_FLAGS': '0x0', 03:20:54 INFO - 'XPC_SERVICE_NAME': '0', 03:20:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20: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 03:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:58 INFO - Downloading docopt-0.6.1.tar.gz 03:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:58 INFO - Running setup.py install for blobuploader 03:20:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:59 INFO - Running setup.py install for requests 03:20:59 INFO - Running setup.py install for docopt 03:20:59 INFO - Successfully installed blobuploader requests docopt 03:20:59 INFO - Cleaning up... 03:20:59 INFO - Return code: 0 03:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:59 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:20:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:59 INFO - 'HOME': '/Users/cltbld', 03:20:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:59 INFO - 'LOGNAME': 'cltbld', 03:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:59 INFO - 'MOZ_NO_REMOTE': '1', 03:20:59 INFO - 'NO_EM_RESTART': '1', 03:20:59 INFO - 'PAGER': '/bin/cat', 03:20:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:59 INFO - 'PWD': '/builds/slave/test', 03:20:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:59 INFO - 'SHELL': '/bin/bash', 03:20:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:20:59 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:20:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:59 INFO - 'USER': 'cltbld', 03:20:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:59 INFO - 'XPC_FLAGS': '0x0', 03:20:59 INFO - 'XPC_SERVICE_NAME': '0', 03:20:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-PSxHEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-0DuBsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-WgQmQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-79gLaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8gscNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jyRdaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-KyXAXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-T4Xbkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-RZtoP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:00 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Kuqtc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-W3sOKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ZLCLsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EfDmpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mS8v0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-t5sKp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-nB4RhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:01 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mxE6c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:01 INFO - Running setup.py install for manifestparser 03:21:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:01 INFO - Running setup.py install for mozcrash 03:21:02 INFO - Running setup.py install for mozdebug 03:21:02 INFO - Running setup.py install for mozdevice 03:21:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Running setup.py install for mozfile 03:21:02 INFO - Running setup.py install for mozhttpd 03:21:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Running setup.py install for mozinfo 03:21:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Running setup.py install for mozInstall 03:21:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:02 INFO - Running setup.py install for mozleak 03:21:03 INFO - Running setup.py install for mozlog 03:21:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:03 INFO - Running setup.py install for moznetwork 03:21:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:03 INFO - Running setup.py install for mozprocess 03:21:03 INFO - Running setup.py install for mozprofile 03:21:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:03 INFO - Running setup.py install for mozrunner 03:21:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:03 INFO - Running setup.py install for mozscreenshot 03:21:04 INFO - Running setup.py install for moztest 03:21:04 INFO - Running setup.py install for mozversion 03:21:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:04 INFO - Cleaning up... 03:21:04 INFO - Return code: 0 03:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:04 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:21:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:04 INFO - 'HOME': '/Users/cltbld', 03:21:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:04 INFO - 'LOGNAME': 'cltbld', 03:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:04 INFO - 'MOZ_NO_REMOTE': '1', 03:21:04 INFO - 'NO_EM_RESTART': '1', 03:21:04 INFO - 'PAGER': '/bin/cat', 03:21:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:04 INFO - 'PWD': '/builds/slave/test', 03:21:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:04 INFO - 'SHELL': '/bin/bash', 03:21:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:21:04 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:21:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:04 INFO - 'USER': 'cltbld', 03:21:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:04 INFO - 'XPC_FLAGS': '0x0', 03:21:04 INFO - 'XPC_SERVICE_NAME': '0', 03:21:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-NJmdHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-znPHYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:04 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)) 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:04 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-AIoyy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-J92gdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:05 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)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-HMPLKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-YyZJqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-o3Xf5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-zcErra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EGO3Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-L3dl21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-dQbrKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xGdWxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:05 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)) 03:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:05 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-hHQc0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VWBBl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:06 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)) 03:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-m5E2cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-9VV60p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:06 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)) 03:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:06 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-t45r4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:21:06 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)) 03:21:06 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)) 03:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:21:06 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)) 03:21:06 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)) 03:21:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:09 INFO - Downloading blessings-1.6.tar.gz 03:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:09 INFO - Installing collected packages: blessings 03:21:09 INFO - Running setup.py install for blessings 03:21:09 INFO - Successfully installed blessings 03:21:09 INFO - Cleaning up... 03:21:09 INFO - Return code: 0 03:21:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:09 INFO - Reading from file tmpfile_stdout 03:21:09 INFO - Current package versions: 03:21:09 INFO - blessings == 1.6 03:21:09 INFO - blobuploader == 1.2.4 03:21:09 INFO - docopt == 0.6.1 03:21:09 INFO - functools32 == 3.2.3-2 03:21:09 INFO - jsonschema == 2.5.1 03:21:09 INFO - manifestparser == 1.1 03:21:09 INFO - mozInstall == 1.12 03:21:09 INFO - mozcrash == 0.17 03:21:09 INFO - mozdebug == 0.1 03:21:09 INFO - mozdevice == 0.48 03:21:09 INFO - mozfile == 1.2 03:21:09 INFO - mozhttpd == 0.7 03:21:09 INFO - mozinfo == 0.9 03:21:09 INFO - mozleak == 0.1 03:21:09 INFO - mozlog == 3.4 03:21:09 INFO - moznetwork == 0.27 03:21:09 INFO - mozprocess == 0.23 03:21:09 INFO - mozprofile == 0.28 03:21:09 INFO - mozrunner == 6.12 03:21:09 INFO - mozscreenshot == 0.1 03:21:09 INFO - mozsystemmonitor == 0.3 03:21:09 INFO - moztest == 0.7 03:21:09 INFO - mozversion == 1.4 03:21:09 INFO - psutil == 3.1.1 03:21:09 INFO - requests == 1.2.3 03:21:09 INFO - wsgiref == 0.1.2 03:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:10 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:21:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:10 INFO - 'HOME': '/Users/cltbld', 03:21:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:10 INFO - 'LOGNAME': 'cltbld', 03:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:10 INFO - 'MOZ_NO_REMOTE': '1', 03:21:10 INFO - 'NO_EM_RESTART': '1', 03:21:10 INFO - 'PAGER': '/bin/cat', 03:21:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:10 INFO - 'PWD': '/builds/slave/test', 03:21:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:10 INFO - 'SHELL': '/bin/bash', 03:21:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:21:10 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:21:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:10 INFO - 'USER': 'cltbld', 03:21:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:10 INFO - 'XPC_FLAGS': '0x0', 03:21:10 INFO - 'XPC_SERVICE_NAME': '0', 03:21:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:21:10 INFO - Cleaning up... 03:21:10 INFO - Return code: 0 03:21:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:10 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 0x10ae2b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ada1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe8b49d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, '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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:21:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:21:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:10 INFO - 'HOME': '/Users/cltbld', 03:21:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:10 INFO - 'LOGNAME': 'cltbld', 03:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:10 INFO - 'MOZ_NO_REMOTE': '1', 03:21:10 INFO - 'NO_EM_RESTART': '1', 03:21:10 INFO - 'PAGER': '/bin/cat', 03:21:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:10 INFO - 'PWD': '/builds/slave/test', 03:21:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:10 INFO - 'SHELL': '/bin/bash', 03:21:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:21:10 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:21:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:10 INFO - 'USER': 'cltbld', 03:21:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:10 INFO - 'XPC_FLAGS': '0x0', 03:21:10 INFO - 'XPC_SERVICE_NAME': '0', 03:21:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:10 INFO - Cleaning up... 03:21:10 INFO - Return code: 0 03:21:10 INFO - Running post-action listener: _resource_record_post_action 03:21:10 INFO - Running post-action listener: _start_resource_monitoring 03:21:10 INFO - Starting resource monitoring. 03:21:10 INFO - [mozharness: 2016-11-07 11:21:10.606550Z] Finished create-virtualenv step (success) 03:21:10 INFO - [mozharness: 2016-11-07 11:21:10.607572Z] Running install step. 03:21:10 INFO - Running pre-action listener: _resource_record_pre_action 03:21:10 INFO - Running main action method: install 03:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:10 INFO - Reading from file tmpfile_stdout 03:21:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:10 INFO - Reading from file tmpfile_stdout 03:21:10 INFO - Output received: 03:21:10 INFO - Usage: mozinstall [options] installer 03:21:10 INFO - Options: 03:21:10 INFO - -h, --help show this help message and exit 03:21:10 INFO - -d DEST, --destination=DEST 03:21:10 INFO - Directory to install application into. [default: 03:21:10 INFO - "/builds/slave/test"] 03:21:10 INFO - --app=APP Application being installed. [default: firefox] 03:21:10 INFO - mkdir: /builds/slave/test/build/application 03:21:10 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'] 03:21:10 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 03:21:43 INFO - Reading from file tmpfile_stdout 03:21:43 INFO - Output received: 03:21:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:21:43 INFO - Running post-action listener: _resource_record_post_action 03:21:43 INFO - [mozharness: 2016-11-07 11:21:43.213286Z] Finished install step (success) 03:21:43 INFO - [mozharness: 2016-11-07 11:21:43.213456Z] Running run-tests step. 03:21:43 INFO - Running pre-action listener: _resource_record_pre_action 03:21:43 INFO - Running main action method: run_tests 03:21:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:43 INFO - 2016-11-07 03:21:43.227 screenresolution[1642:7459] starting screenresolution argv=screenresolution get 03:21:43 INFO - 2016-11-07 03:21:43.230 screenresolution[1642:7459] Display 0: 1600x1200x32@60 03:21:43 INFO - 2016-11-07 03:21:43.236 screenresolution[1643:7461] starting screenresolution argv=screenresolution list 03:21:43 INFO - Available Modes on Display 0 03:21:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:43 INFO - Intel Iris: 03:21:43 INFO - Chipset Model: Intel Iris 03:21:43 INFO - Type: GPU 03:21:43 INFO - Bus: Built-In 03:21:43 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:43 INFO - Vendor: Intel (0x8086) 03:21:43 INFO - Device ID: 0x0a2e 03:21:43 INFO - Revision ID: 0x0009 03:21:43 INFO - Displays: 03:21:43 INFO - Display: 03:21:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:43 INFO - Display Serial Number: 1600x1200 60 03:21:43 INFO - Main Display: Yes 03:21:43 INFO - Mirror: Off 03:21:43 INFO - Online: Yes 03:21:43 INFO - Rotation: Supported 03:21:43 INFO - Return code: 0 03:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:43 INFO - Python 2.7.3 03:21:43 INFO - Return code: 0 03:21:43 INFO - grabbing minidump binary from tooltool 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:43 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 0x10ac3fd30>, '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 0x10aaa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac37b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:21:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:21:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:21:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:43 INFO - Return code: 0 03:21:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:21:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:21:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:43 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/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:21:43 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/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKFfNzJB7z/Render', 03:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:43 INFO - 'HOME': '/Users/cltbld', 03:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PAGER': '/bin/cat', 03:21:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test', 03:21:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FBoZHJlz1D/Listeners', 03:21:43 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 03:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - 'XPC_FLAGS': '0x0', 03:21:43 INFO - 'XPC_SERVICE_NAME': '0', 03:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:43 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/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:21:43 INFO - mozversion application_buildid: 20161107004002 03:21:43 INFO - mozversion application_changeset: 8027a7b723c9db7254bdb0bea3bc8937220daa7e 03:21:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:21:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:43 INFO - mozversion application_name: Firefox 03:21:43 INFO - mozversion application_remotingname: firefox-dev 03:21:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:21:43 INFO - mozversion application_vendor: Mozilla 03:21:43 INFO - mozversion application_version: 51.0a2 03:21:43 INFO - mozversion platform_buildid: 20161107004002 03:21:43 INFO - mozversion platform_changeset: 8027a7b723c9db7254bdb0bea3bc8937220daa7e 03:21:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:21:43 INFO - mozversion platform_version: 51.0a2 03:21:43 INFO - using testdate: 1478517703 03:21:43 INFO - actual date: 1478517703 03:21:43 INFO - starting webserver on 'localhost:49279' 03:21:43 INFO - SUITE-START | Running 2 tests 03:21:43 INFO - TEST-START | dromaeo_css 03:21:43 INFO - operating with platform_type : mac_ 03:21:43 INFO - Initialising browser for dromaeo_css test... 03:21:43 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpTZu4B1/profile http://localhost:49279/getInfo.html) 03:21:46 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 03:21:46 INFO - PROCESS | 1653 | colorDepth:24 03:21:46 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 03:21:46 INFO - PROCESS | 1653 | __metrics 03:21:46 INFO - PROCESS | 1653 | 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" 03:21:46 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:21:47 INFO - TEST-INFO | 1653: exit 0 03:21:47 INFO - Browser initialized. 03:21:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:47 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpTZu4B1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:59 INFO - PROCESS | 1656 | RSS: Main: 219852800 03:21:59 INFO - PROCESS | 1656 | 03:22:50 INFO - PROCESS | 1656 | 1478517770460 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] 03:25:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 03:25:03 INFO - PROCESS | 1656 | RSS: Main: 365486080 03:25:03 INFO - PROCESS | 1656 | 03:28:06 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 03:28:07 INFO - PROCESS | 1656 | RSS: Main: 352604160 03:28:07 INFO - PROCESS | 1656 | 03:31:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 03:31:10 INFO - PROCESS | 1656 | RSS: Main: 332840960 03:31:10 INFO - PROCESS | 1656 | 03:34:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 03:34:13 INFO - PROCESS | 1656 | RSS: Main: 329617408 03:34:13 INFO - PROCESS | 1656 | 03:37:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 03:37:17 INFO - PROCESS | 1656 | RSS: Main: 312033280 03:37:17 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 03:40:20 INFO - PROCESS | 1656 | RSS: Main: 496566272 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | __start_tp_report 03:40:20 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 03:40:20 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 03:40:20 INFO - PROCESS | 1656 | |i|pagename|runs| 03:40:20 INFO - PROCESS | 1656 | |0;dojo.html;3280.9835950820247;3324.9002529924096;3352.5306457095994;3363.2432702641922;3398.099503631538;4832;5666.291713535808;5678.744456499458;5690.203371527984;5695.800646977352;5631.831045068644;5674.716264186794;5714.028615135427;5720;5736.598438109334;5184.559312458446;5198.220266959967;5208.2968799212185;5239.816606418776;5255.658382205163;5130.743462826844;5163.251328557357;5174.586033117342;5309.150535914255;5341.439148889369;5167.302414174076;5172.560332371753;5202.219667049935;5248.947510524903;5266.894662106755;5190.403103643072;5213.2701421800975;5216.191490319006;5264.105102132647;5274.92087618686;5121.385433747937;5226.947730522684;5228.47715228478;5230.503102205284;5260.842174734764;5481.095619222863;5534.391216966131;5545.195946587723;5608.4111168327145;5705.315362156526;6130.061839218042;6211.19254496917;6219.937800621981;6229.190205273286;6259.530535209878;6208.472279856218;6301.369863013708;6305.022721478178;6309.08518264849;6314.210723659543;5689.573282003867;5755.568332375088;5757.337906140764;5758.7696492140685;5761.5678824087945;6257.78097766576;6291.528135389773;6334.3032266450655;6344.048392741126;6370.77702280418;6100.298465676504;6136.386361363828;6141;6144.2319710036245;6154.415330543591;6089.939100609025;6101.542384321194;6247.344028876993;6271.560990730605;6291.874162516724;6001.669908155093;6104.495119187285;6116.969415152896;6126.082987924418;6161.322254551996;6186.845328866814;6205.410486003822;6206.317305096436;6208.875822483525;6215.782447614311;4830.9275360869615;4904.656674032854;4922.433920099163;4928.654994150375;4935.87660308488;4369.994901172748;4411.985243394038;4428.6678499112695;4455.710378825366;4472.865814025585;5711.457411545896;5765.221695071112;5785.768569257182;5809.622374545641;5860.824175274749;6247.937520624736;6252.406021427957;6273.560850740496;6285.308616052231;6290.622562646256;5604.467575580314;5726.742296596663;5815.680137592473;5819.505342045889;5821.2141360916585;4550.567696068868;5297.258383826267;5340.519353258225;5384.865378365494;5408.107662235687;6226.5641405101205;6291.119243306032;6292.653904035139;6295.087212354275;6301.369863013662;6245.437910588069;6278.434940855345;6281.246250449975;6300.621962682254;6318.968405157945;6228.096925945803;6234.657093859882;6239.656818875005;6264.843378915381;6303.36966303366;6105.114758359924;6196.535259855439;6199.659018754011;6214.720337584729;6219.346968568416;5504.504594586507;5977;6298.275698294755;6306.180196574416;6311.116443697978;5871.911921321269;5939.168516407793;5943.702814859326;6052.818415447544;6092.208012958465;5043.42000669913;5971.104334349882;6063.878722425615;6139.4781443577795;6144.924638188389;5955.255593050869;5962.433568810956;5963.016102343065;5984.790532331347;6014.188084608521;5908.734106965283;6063.909041364295;6123.2958209804665;6134.693265336626;6137.7851775187655;5798.768049277982;5814.883702326015;5904.9704751475965;5916.792912248051;5932.2584676915385 03:40:20 INFO - PROCESS | 1656 | |1;ext.html;479.50371365636573;510.4589135516353;516.8501134670946;528.3263838605777;550.7439040846007;29867.402651946948;40102;41065.17869642602;41263.17473650525;44034.33948490775;41667.79166104173;41686;42008.57991420085;42749.35875961863;43218.783906080505;8638.913610863905;9686.903130968689;9889.604415823394;9917.702468925943;9929.404235745842;8810.691625793099;8891.95554022229;8897.644094236255;8900.688475903346;12006.979406750437;11919.165658403916;12239.449224784861;12247.265164090182;12259.141860069798;12280.938595307056;12229.510819567207;12295.815562766566;12305.876941230563;12353.011759059254;12354.505819767244;12007.219530730561;12099.032077433872;12113.818292725617;12113.878861211364;12114.697132571757;40112.997175070566;40325.59674403277;40445.393319099945;40476;40503;3321.551590535271;3389.5593572835373;3434.8969530914114;3461.498082778008;3786.753860999026;30598.84700576483;30907;31107.688923110705;31459.213519661964;32135.839320803247;3134.984325078383;3255.641879393265;3283.2612662150823;3323.8670453181844;3338.3490219407227;385381;391669;391886;398158.9999999971;404203;58179.41820581825;58450.4154958445;58583;58616.70691646515;58662.70668646629;34227.65772342295;35158.64841351554;35194.76818311347;62367.6881615589;62655;16248.59378515523;16651.91674041622;16723.83276167247;16753.832461675473;16783.16084195785;12776.105672603015;12807.423665935055;12830.67923301925;12864.356782160854;12875.163114397721;16337.67324653524;16684.83315166833;16686.49940501787;18840.717389239173;19001.904990475236;7066.787996360117;7381.704731810667;7597.164311925684;7617.238276172449;7812.453128280966;869.3088994249587;912.7358608327514;942.783159873233;1013.8884722680499;1091.6724982505216;25209.747902521107;28651.42697146087;29671.851640741657;29809.85095074511;30404.391912161635;1011.3072545306488;1056.9682909512726;1074.537948682074;1082.6968448834339;1099.8295264234057;15030.774538381933;15470;15533.068015918854;15613.609659758597;15760.133192674513;713313;716112.8388716046;717637;719101;720157.3992130005;44399.55600443954;49222;50107.74946125246;56488.717556412776;57527.71236143876;1367.685432350565;1378.8414332351708;1388.187910072619;1389.5275606293908;1394.3446580107334;29358.853205733834;29454.263643409085;30150.698493015665;30466.84766576153;30619.2345191372;43824;48181.759091204316;48405.75797120992;48461;48600.270995935796;608941;617101;622444;622650.8867455815;623553;25955.351116222246;26345.473090538464;26345.86827065929;26456.338591534597;26480.735192647826;45329.77335113303;46480.070398592514;46937.06125877531;47425.52574474211;47751.76124119357;38079;38482;39248.01879953024;39397;40716.79641601773;29929;38089;38145.80927095347;38505;40067.59932400638;37108.6289137116;37112.81443592765;37232.62767372291;37867.431988519646;37985;32325.67674323321;33942;34719.13202169865;34797.82601086979;34944.475832862016;25023.87488062621;25108.62337064982;25537.744622553535;25600.487990240465;25674.358141046625 03:40:20 INFO - PROCESS | 1656 | |2;jquery.html;353.1013570463171;368.4951616285687;380.990475238119;381.62219402791237;399.2354640862748;14936.925315373435;15034.624134396645;16425.014499130044;20523.38429847103;20902;19781.307654232103;20402.591948161065;20930.953452327398;20986.685199722015;21235.345581802274;4520.7739613019385;5811.941880581193;6084.878302433971;6088.543359248052;6090.208272924514;5040.495950404948;6004.0693692477735;6031;6046;6060.000099983497;5628.718564071801;5782;5984.401559844003;5985.521158307347;5991.370906054867;5879.529637629001;5913.763449462016;5916.3787802280785;5934.821955341346;5944.940550594503;4914;5082.1360368737405;5156.381234251876;5157.432682404932;5162.819301324474;25951;26001.869990650113;26016.479670406676;26052;26360.8681956589;2241.4060274027397;2252.549490101986;2271.3980795089315;2283.189467738962;2455.4475243070347;12260.386980651021;14441.277936103257;14821.555353339418;15753.527394178192;15859;1868.4768264885854;1891.8013608571177;1907.3229003703625;1960.7156962240538;2008.7288216090933;115736;122379;123507;125234.73826308739;127195.36402318021;10464.686059418078;10593.099586535076;10974.725631859268;10994.34033957965;11147.219694621299;13614.251216183206;13630.522931697344;13631.182129072287;13652.795208071886;13660.248686322348;7740.651670674833;8307.961504811898;8344.958275208706;8695.00007499133;8795.780105497413;7056.329648683367;8704.78238044054;8752.081031491729;8919.910800892038;8943.463392196489;6459.677016149268;6587.835304117435;6593.142891424084;6601.273859875506;6708.765193218214;1871.822176893193;1873.3536929759211;1874.8593855460895;1885.641728071662;1886.2455017992638;829.995850020746;936.344558808823;939.8073394954018;1016.4358780876537;1043.4834756795435;20924.89537552333;21317.893410533157;21368.572628547343;21373.67939480909;21487.247946321804;958.7986522830145;968.7335982604699;974.3241624406011;996.6461906023402;998.5007496251874;9895.60417583303;10853.34879907208;10855.294405863593;11274.436278186058;11436.656900292837;609773;614679.1192528462;616892;626318;634527;88392;121591.39204303922;127614.72385276214;139919;140928;960.3229723045237;984.778424854402;1017.2167431078028;1072.383379556758;1073.9248252622397;18146.637067258318;18292.45122646323;19106.808931910502;19281.516521531234;19474.221031159163;59051.818963619626;60102.699486502286;61011.38988610057;61088.694556526934;61372;68005.65997169983;77596.83604746046;80985.59507202427;82314.58842705748;85383;7970.800729981797;8038.236367545074;8145.185481451807;8267.379946504156;8333.95833020831;11290.774184516427;11347.411362409104;12949.805752913902;13050.738985220432;13196.934015329862;10925.726856828644;11206.047485963785;11333.659990200307;11414.600488982845;11418.771624567627;11052.944735276273;11106.389148596581;11364.920332568392;11414.942925285653;11522.711932201426;11487.655370338904;11491.597794077166;11637.825432618349;11655.59205427806;11674.124440666814;8164.83670326602;8220.753377398687;8236.382271329794;8255.050669173123;8259.297959673495;9191;9354.438733676001;11002.614908478165;11436;11492.82760758606 03:40:20 INFO - PROCESS | 1656 | |3;mootools.html;1408.7605107131787;1499.3777582303344;1693.3142077458633;1853.6756067688152;1895.1377123408859;7709.807254818632;8177.509349439038;8442.07137214906;9198.448093114417;9245;8297.1702829717;8728.825423491542;8920.910790892089;8930.866037009433;9076.410033347827;2402.9639555406684;2428.6721292625534;2431.65956766052;2432.6959130108735;2433;1754.5789010637418;2375.1829850164636;2413.1071503543712;2415.915442959497;2416.504616553611;2006.3278801601407;2010.3164923925863;2148.4736239621316;2390.3187591536416;2398.4843258699375;2397.9760202398015;2400.411899084718;2428.7449817769057;2431.0640403444622;2437.6709144265474;2408.1330720940446;2413.915512957038;2435.585950388438;2437.9512409751883;2443.486867757773;8950.14973577509;8984.730458086267;8987.505687187202;9011.729648110502;9015.143561361725;5355.544778693816;5433.239346491494;5503.972480137613;5517.862053448655;5533.750981205855;3510.6489351064943;3640.4721315409383;3701.9259614807825;3704.1665625234377;3717.5910649828766;1069.2034434346463;1093.9617113400993;1101.0530943388678;1115.8828323026046;1121.030308782897;11676.29942203462;11958.760824783543;11974.940125299318;11979.520819167223;12017.93991030048;4725.9527404726205;4733.414154105856;4806.44725856524;4920.950790492049;4929.383827021622;8663.436876603;10196.745081372877;10217.438040907822;10221.386716797017;10247.7438064049;5426.348838139448;5443.074677304789;5453.945460545423;5458.5087342139395;5460.290162278958;4849.2726091086615;4928.112939670822;4943.826966056171;4972.328735620717;4976.104301225814;3698.3158115748674;3898.941515877264;3965.5439624442984;3995.9800200998807;4021.2560676274984;1197.7484728207;1213.5691829400437;1260.5840072775961;1271.7011502296953;1284.5118854835102;688.5902887781762;807.4065561812064;866.2544971881664;872.3457406944791;893.7854914820397;5832.1834943108;5922.496587790086;5925.822225333247;5983.222181116427;6210.875782484325;872.7818045488627;896.6503063805121;897.7217062710581;913.2374467319729;925.8889332800666;3461.3077384522694;3977.5624681285035;3984.30274701926;4111.506619205715;4142.523609784913;10422.009909058628;10823.188260880466;10990.065844403316;11110.333379997226;11120.99911008013;10991.230613857113;11137.665870023913;11142.387168705636;11152.944235278772;11156;8224.62989165489;8368.53973031477;8426.831463370698;8454.492730436194;8460.280876125475;5808.419158084158;5896.469317761422;6006.969965150146;6008.579399441997;6014.699265036818;10247.94876025645;10296.970302969643;10321.174306055347;10352.896471035194;10400.843987340348;8465;9939.254555908192;10369.792604148026;10447.791044179226;10490.580376784843;7644.847103058019;7829.765107046797;7831.2560306770765;7833.216678332121;7846.450748447553;8327.833443330977;8387.119352467904;8418.747437576883;8451.577421129043;8464.068952415106;6255.24937007562;7466;7508.474406791691;7557.697692092254;7588.165301816906;7415.295546923249;7489.13874904393;7497.850042999;7500.212477689764;7548.5470871747875;6884.070650462324;7053.365197132282;7076.929230707627;7145.64271786419;7151.642417879189;4245.830166793294;5066.594672426123;5075.92386114216;5102.566281865935;5172.75853795094;5036.420811606712;5040.395152581714;5066.695998240118;5220.660657057279;5248.343957005374 03:40:20 INFO - PROCESS | 1656 | |4;prototype.html;301.08019998903353;302.0500525846215;311.6836411042791;314.27245925682047;317.0346295530111;4629.699069560476;5133.1786914093755;5178.249153872686;5179.559737422314;5455.490474381784;4756.833510827122;5189.652674025261;5344.91982620261;5349.769553002802;5395.757190926408;3526.629703881094;3924.4701965234613;4049.9595004050025;4058.1680755445136;4092.3452247640384;4120.835166593332;4170.686233836347;4172.874813755592;4192.454980852485;4218.957810421903;3403.914902127442;3854.8650797222103;4003.4586684126675;4064.4309796628495;4091.672666186698;4030.266985196364;4038;4096.242195193899;4120.237756015132;4127.814248358816;3489.773164744309;3518.6833185013215;3522.806245656488;3525.2773181497732;3533.9823300883586;4404.317330813729;4892.608591312686;5321.323783008379;5361.624686271963;5366.624336296461;3738.420544815531;4617.676762626617;4632.374629425019;4638.304254361839;4638.397008388922;5634.323881134249;5652.293463317085;5683.630564013326;5727.1695604137585;5729.450394574416;3319.55186049885;3596.1908570571672;3836.9040773980596;3840.0815380310887;3851.8844434667003;4643.976780116078;5624.71876406178;5947.494462970652;6036.185115009505;6045.395460453963;3618.9095272618397;3801.125741079567;3898.317794385971;3924.5871486264923;3946.1910308386714;3116.0028790787183;3658.670719635192;3731.6641502264924;3835.5013848200115;4018.8995275118355;3894.863679771251;4426.535213802569;4649.395578574764;4721.929171062437;4742.502037286035;4646.953530464652;5064;5661.858453538694;5769.278840144982;5810.709464526842;1146.4668928948079;1285.1453783234044;1330.8953568538284;1354.1739538881275;1361.9727605447836;818.4761752478419;846.1115828380299;854.4019186569426;879.6481407436949;917.6742256498981;4065.2072845794787;4938.308636790852;4941.505849415102;5215.061288968022;5371.382291036581;5374.5700343972385;5820.272465941757;5867.383924687846;5881.794137205177;5901.970490147522;4556.931646025312;5132.81945152617;5313.203019547099;5336.306280183551;5439.864003399867;2715.1672620980758;2996.2209825445543;3099.535069739557;3106.3476669899123;3111.7043880831284;5278.9208161877605;5597.124963137313;5737.995850726106;5756.25168728071;6162.599431036968;4998;5136.8715782105;6045.939540604626;6049.882541110576;6078.300995385499;5307.840764777063;5536.944630553723;5925.563173359441;6085.786997455068;6157.291911430153;4630;5032.716657252377;5702.657840529581;5760.366359700346;5871.295444546682;5132.947745712195;5641.871625674964;5654.180143879197;5679.801206957736;5710.628809127394;5743.19089486827;6019.819405417845;6027.728752206073;6033.939660603338;6055.848603784941;3866.7099967503113;3887.3391523441646;3915.4126880968083;3941.625545573166;3954.9406758899213;5843.94156058434;5925.585209035326;5956.880862382642;5996.481477779256;6017.382438639206;4433.556644335541;4905.730184839868;4944.244793098542;5619.044762390322;5810.215620891295;4914;5603.55171586264;5667.801626943037;5843.474087331991;5846.239988801429;5375.19372094189;5420.891582168413;5660.632058916157;5742.454466825645;5753.079507278815;4487.461504619467;4599.701019433726;5764.827055188351;5777.291507421438;5790.420957904176;5122.718250496258;5634.32388113429;5635.464630860061;5638.097904335286;5646.604737668324 03:40:20 INFO - PROCESS | 1656 | |5;yui.html;697.815079004064;748.7753673897829;768.523515420439;789.3685051958433;806.3670019035056;15740.527784166465;16491.422800201995;16513.66972660549;16522.504324870257;16528.256228469716;14773.409063637468;14946.177960212184;14953.47662831801;14957.551273461786;14969.47606833761;654.4241067860277;674.9561278516906;678.575890068707;830.0330115415549;854.799122206281;822.5722624235394;846.3736834742277;848.8854004709347;855.1405837133672;856.0754385263931;911.3483859040784;911.4121391702348;912.2018234045211;912.9771755706095;913.968011119611;903.5527413930147;904.1320332480826;904.8190361927608;905.3436258712446;905.3933864310861;522.8875791704763;536.8147988943847;650.1093501902377;669.4042302350912;677.8102131403215;15113;15214.695706085928;15232.771508427382;15236.23818809055;15243.923780381137;13879.306034698224;14188.006839521238;14237.43050277998;14404.711905761826;14531.200783956878;12385.256884586954;12550.81173782394;12663.30351830649;12858.421371038326;13217.471301147943;4376.715513491645;4525.615322697575;4543.34121552373;4688.156131896258;4773.379460670126;124433.75566244312;126309.89520838311;127669;129787.35106324407;129830;10595.09941654968;10985.505652245669;11282.097432205404;11329.320240785579;11352.886471135183;22874.31377058691;22992.770072299063;23004.884975575016;23107;23389.766102339097;8118.959405202936;8158;8173.18268173178;8241.093479717227;8414.158584141536;4368.956310436855;4387.583179597933;4609.884752881205;4620.884477888079;4719;3551.733619978512;3631.4915911772373;3662.359087159736;3667.7799332040163;3675.1363429594026;661.5270081891471;666.6133642487346;670.5272782688193;674.305465370669;686.9622170780555;584.541135208859;615.2125279641975;617.3671986214166;623.4420193926501;629.4523764325066;8457.942757155355;8494.532800695897;8989.730308090768;9055.23030542398;9323.72028839136;522.6028218553851;562.9014922388566;574.8965186266429;578.8089930322983;579.4495229531962;4211.284081706117;4471.6646251531265;4478.48497422794;4505.144022635689;4541.159885421208;100727;101097.49451252844;103371.44942825864;142083;164143;113780;113867.19920119821;119304;121114.78885211212;123528;64814;66616;92560.61159082619;97974.02025979792;108955.45522272655;9336.253099751868;9338.319102561603;9583.616655333988;9771.951140244253;9999.150072243941;61528.69235653793;63032.68483657552;64266.67866660637;64861;65554.01668974874;91233.08766912245;96233.5188324082;98832.51751223594;101509;101650.49174754079;12165.513379464723;12342.382880856101;12573.371331433575;12857.357132143543;12898.161619494704;13864.86135138676;14531.92734036323;14821.40714371413;15251.694966100838;15422.305996229972;13181.406836692564;13236.073474856668;13448.394822232827;13949.930250348683;14152.858471415566;12574.748505030031;13612.979026572848;13658.658533536742;13792.517261896186;14221.502247421291;12323.630291091282;13539.59381218565;13665.248411337074;14097;14111.788323174955;10402.687919362432;11320.660380188607;11364.54541818318;11441.771164576829;11604.361760103275;8806.735797926072;11217.55129794799;11394.829077564009;11635.243709158878;11671.183017188716 03:40:20 INFO - PROCESS | 1656 | __end_tp_report 03:40:20 INFO - PROCESS | 1656 | __start_cc_report 03:40:20 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1358 03:40:20 INFO - PROCESS | 1656 | __end_cc_report 03:40:20 INFO - PROCESS | 1656 | __startTimestamp1478518820789__endTimestamp 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | ------- Summary: start ------- 03:40:20 INFO - PROCESS | 1656 | Number of tests: 6 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5716.20 Median:5916.79 stddev:646.91 (10.9%) stddev-sans-first:620.04 03:40:20 INFO - PROCESS | 1656 | Values: 3281.0 3324.9 3352.5 3363.2 3398.1 4832.0 5666.3 5678.7 5690.2 5695.8 5631.8 5674.7 5714.0 5720.0 5736.6 5184.6 5198.2 5208.3 5239.8 5255.7 5130.7 5163.3 5174.6 5309.2 5341.4 5167.3 5172.6 5202.2 5248.9 5266.9 5190.4 5213.3 5216.2 5264.1 5274.9 5121.4 5226.9 5228.5 5230.5 5260.8 5481.1 5534.4 5545.2 5608.4 5705.3 6130.1 6211.2 6219.9 6229.2 6259.5 6208.5 6301.4 6305.0 6309.1 6314.2 5689.6 5755.6 5757.3 5758.8 5761.6 6257.8 6291.5 6334.3 6344.0 6370.8 6100.3 6136.4 6141.0 6144.2 6154.4 6089.9 6101.5 6247.3 6271.6 6291.9 6001.7 6104.5 6117.0 6126.1 6161.3 6186.8 6205.4 6206.3 6208.9 6215.8 4830.9 4904.7 4922.4 4928.7 4935.9 4370.0 4412.0 4428.7 4455.7 4472.9 5711.5 5765.2 5785.8 5809.6 5860.8 6247.9 6252.4 6273.6 6285.3 6290.6 5604.5 5726.7 5815.7 5819.5 5821.2 4550.6 5297.3 5340.5 5384.9 5408.1 6226.6 6291.1 6292.7 6295.1 6301.4 6245.4 6278.4 6281.2 6300.6 6319.0 6228.1 6234.7 6239.7 6264.8 6303.4 6105.1 6196.5 6199.7 6214.7 6219.3 5504.5 5977.0 6298.3 6306.2 6311.1 5871.9 5939.2 5943.7 6052.8 6092.2 5043.4 5971.1 6063.9 6139.5 6144.9 5955.3 5962.4 5963.0 5984.8 6014.2 5908.7 6063.9 6123.3 6134.7 6137.8 5798.8 5814.9 5905.0 5916.8 5932.3 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:70233.04 Median:35176.71 stddev:158955.39 (451.9%) stddev-sans-first:159315.02 03:40:20 INFO - PROCESS | 1656 | Values: 479.5 510.5 516.9 528.3 550.7 29867.4 40102.0 41065.2 41263.2 44034.3 41667.8 41686.0 42008.6 42749.4 43218.8 8638.9 9686.9 9889.6 9917.7 9929.4 8810.7 8892.0 8897.6 8900.7 12007.0 11919.2 12239.4 12247.3 12259.1 12280.9 12229.5 12295.8 12305.9 12353.0 12354.5 12007.2 12099.0 12113.8 12113.9 12114.7 40113.0 40325.6 40445.4 40476.0 40503.0 3321.6 3389.6 3434.9 3461.5 3786.8 30598.8 30907.0 31107.7 31459.2 32135.8 3135.0 3255.6 3283.3 3323.9 3338.3 385381.0 391669.0 391886.0 398159.0 404203.0 58179.4 58450.4 58583.0 58616.7 58662.7 34227.7 35158.6 35194.8 62367.7 62655.0 16248.6 16651.9 16723.8 16753.8 16783.2 12776.1 12807.4 12830.7 12864.4 12875.2 16337.7 16684.8 16686.5 18840.7 19001.9 7066.8 7381.7 7597.2 7617.2 7812.5 869.3 912.7 942.8 1013.9 1091.7 25209.7 28651.4 29671.9 29809.9 30404.4 1011.3 1057.0 1074.5 1082.7 1099.8 15030.8 15470.0 15533.1 15613.6 15760.1 713313.0 716112.8 717637.0 719101.0 720157.4 44399.6 49222.0 50107.7 56488.7 57527.7 1367.7 1378.8 1388.2 1389.5 1394.3 29358.9 29454.3 30150.7 30466.8 30619.2 43824.0 48181.8 48405.8 48461.0 48600.3 608941.0 617101.0 622444.0 622650.9 623553.0 25955.4 26345.5 26345.9 26456.3 26480.7 45329.8 46480.1 46937.1 47425.5 47751.8 38079.0 38482.0 39248.0 39397.0 40716.8 29929.0 38089.0 38145.8 38505.0 40067.6 37108.6 37112.8 37232.6 37867.4 37985.0 32325.7 33942.0 34719.1 34797.8 34944.5 25023.9 25108.6 25537.7 25600.5 25674.4 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:35984.73 Median:14203.22 stddev:103447.16 (728.3%) stddev-sans-first:103702.76 03:40:20 INFO - PROCESS | 1656 | Values: 353.1 368.5 381.0 381.6 399.2 14936.9 15034.6 16425.0 20523.4 20902.0 19781.3 20402.6 20931.0 20986.7 21235.3 4520.8 5811.9 6084.9 6088.5 6090.2 5040.5 6004.1 6031.0 6046.0 6060.0 5628.7 5782.0 5984.4 5985.5 5991.4 5879.5 5913.8 5916.4 5934.8 5944.9 4914.0 5082.1 5156.4 5157.4 5162.8 25951.0 26001.9 26016.5 26052.0 26360.9 2241.4 2252.5 2271.4 2283.2 2455.4 12260.4 14441.3 14821.6 15753.5 15859.0 1868.5 1891.8 1907.3 1960.7 2008.7 115736.0 122379.0 123507.0 125234.7 127195.4 10464.7 10593.1 10974.7 10994.3 11147.2 13614.3 13630.5 13631.2 13652.8 13660.2 7740.7 8308.0 8345.0 8695.0 8795.8 7056.3 8704.8 8752.1 8919.9 8943.5 6459.7 6587.8 6593.1 6601.3 6708.8 1871.8 1873.4 1874.9 1885.6 1886.2 830.0 936.3 939.8 1016.4 1043.5 20924.9 21317.9 21368.6 21373.7 21487.2 958.8 968.7 974.3 996.6 998.5 9895.6 10853.3 10855.3 11274.4 11436.7 609773.0 614679.1 616892.0 626318.0 634527.0 88392.0 121591.4 127614.7 139919.0 140928.0 960.3 984.8 1017.2 1072.4 1073.9 18146.6 18292.5 19106.8 19281.5 19474.2 59051.8 60102.7 61011.4 61088.7 61372.0 68005.7 77596.8 80985.6 82314.6 85383.0 7970.8 8038.2 8145.2 8267.4 8334.0 11290.8 11347.4 12949.8 13050.7 13196.9 10925.7 11206.0 11333.7 11414.6 11418.8 11052.9 11106.4 11364.9 11414.9 11522.7 11487.7 11491.6 11637.8 11655.6 11674.1 8164.8 8220.8 8236.4 8255.1 8259.3 9191.0 9354.4 11002.6 11436.0 11492.8 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5791.75 Median:4958.08 stddev:3267.71 (65.9%) stddev-sans-first:3260.28 03:40:20 INFO - PROCESS | 1656 | Values: 1408.8 1499.4 1693.3 1853.7 1895.1 7709.8 8177.5 8442.1 9198.4 9245.0 8297.2 8728.8 8920.9 8930.9 9076.4 2403.0 2428.7 2431.7 2432.7 2433.0 1754.6 2375.2 2413.1 2415.9 2416.5 2006.3 2010.3 2148.5 2390.3 2398.5 2398.0 2400.4 2428.7 2431.1 2437.7 2408.1 2413.9 2435.6 2438.0 2443.5 8950.1 8984.7 8987.5 9011.7 9015.1 5355.5 5433.2 5504.0 5517.9 5533.8 3510.6 3640.5 3701.9 3704.2 3717.6 1069.2 1094.0 1101.1 1115.9 1121.0 11676.3 11958.8 11974.9 11979.5 12017.9 4726.0 4733.4 4806.4 4921.0 4929.4 8663.4 10196.7 10217.4 10221.4 10247.7 5426.3 5443.1 5453.9 5458.5 5460.3 4849.3 4928.1 4943.8 4972.3 4976.1 3698.3 3898.9 3965.5 3996.0 4021.3 1197.7 1213.6 1260.6 1271.7 1284.5 688.6 807.4 866.3 872.3 893.8 5832.2 5922.5 5925.8 5983.2 6210.9 872.8 896.7 897.7 913.2 925.9 3461.3 3977.6 3984.3 4111.5 4142.5 10422.0 10823.2 10990.1 11110.3 11121.0 10991.2 11137.7 11142.4 11152.9 11156.0 8224.6 8368.5 8426.8 8454.5 8460.3 5808.4 5896.5 6007.0 6008.6 6014.7 10247.9 10297.0 10321.2 10352.9 10400.8 8465.0 9939.3 10369.8 10447.8 10490.6 7644.8 7829.8 7831.3 7833.2 7846.5 8327.8 8387.1 8418.7 8451.6 8464.1 6255.2 7466.0 7508.5 7557.7 7588.2 7415.3 7489.1 7497.9 7500.2 7548.5 6884.1 7053.4 7076.9 7145.6 7151.6 4245.8 5066.6 5075.9 5102.6 5172.8 5036.4 5040.4 5066.7 5220.7 5248.3 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4562.79 Median:5127.77 stddev:1423.05 (27.8%) stddev-sans-first:1390.63 03:40:20 INFO - PROCESS | 1656 | Values: 301.1 302.1 311.7 314.3 317.0 4629.7 5133.2 5178.2 5179.6 5455.5 4756.8 5189.7 5344.9 5349.8 5395.8 3526.6 3924.5 4050.0 4058.2 4092.3 4120.8 4170.7 4172.9 4192.5 4219.0 3403.9 3854.9 4003.5 4064.4 4091.7 4030.3 4038.0 4096.2 4120.2 4127.8 3489.8 3518.7 3522.8 3525.3 3534.0 4404.3 4892.6 5321.3 5361.6 5366.6 3738.4 4617.7 4632.4 4638.3 4638.4 5634.3 5652.3 5683.6 5727.2 5729.5 3319.6 3596.2 3836.9 3840.1 3851.9 4644.0 5624.7 5947.5 6036.2 6045.4 3618.9 3801.1 3898.3 3924.6 3946.2 3116.0 3658.7 3731.7 3835.5 4018.9 3894.9 4426.5 4649.4 4721.9 4742.5 4647.0 5064.0 5661.9 5769.3 5810.7 1146.5 1285.1 1330.9 1354.2 1362.0 818.5 846.1 854.4 879.6 917.7 4065.2 4938.3 4941.5 5215.1 5371.4 5374.6 5820.3 5867.4 5881.8 5902.0 4556.9 5132.8 5313.2 5336.3 5439.9 2715.2 2996.2 3099.5 3106.3 3111.7 5278.9 5597.1 5738.0 5756.3 6162.6 4998.0 5136.9 6045.9 6049.9 6078.3 5307.8 5536.9 5925.6 6085.8 6157.3 4630.0 5032.7 5702.7 5760.4 5871.3 5132.9 5641.9 5654.2 5679.8 5710.6 5743.2 6019.8 6027.7 6033.9 6055.8 3866.7 3887.3 3915.4 3941.6 3954.9 5843.9 5925.6 5956.9 5996.5 6017.4 4433.6 4905.7 4944.2 5619.0 5810.2 4914.0 5603.6 5667.8 5843.5 5846.2 5375.2 5420.9 5660.6 5742.5 5753.1 4487.5 4599.7 5764.8 5777.3 5790.4 5122.7 5634.3 5635.5 5638.1 5646.6 03:40:20 INFO - PROCESS | 1656 | 03:40:20 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24014.88 Median:3671.46 stddev:37307.13 (1016.1%) stddev-sans-first:37370.71 03:40:20 INFO - PROCESS | 1656 | Values: 697.8 748.8 768.5 789.4 806.4 15740.5 16491.4 16513.7 16522.5 16528.3 14773.4 14946.2 14953.5 14957.6 14969.5 654.4 675.0 678.6 830.0 854.8 822.6 846.4 848.9 855.1 856.1 911.3 911.4 912.2 913.0 914.0 903.6 904.1 904.8 905.3 905.4 522.9 536.8 650.1 669.4 677.8 15113.0 15214.7 15232.8 15236.2 15243.9 13879.3 14188.0 14237.4 14404.7 14531.2 12385.3 12550.8 12663.3 12858.4 13217.5 4376.7 4525.6 4543.3 4688.2 4773.4 124433.8 126309.9 127669.0 129787.4 129830.0 10595.1 10985.5 11282.1 11329.3 11352.9 22874.3 22992.8 23004.9 23107.0 23389.8 8119.0 8158.0 8173.2 8241.1 8414.2 4369.0 4387.6 4609.9 4620.9 4719.0 3551.7 3631.5 3662.4 3667.8 3675.1 661.5 666.6 670.5 674.3 687.0 584.5 615.2 617.4 623.4 629.5 8457.9 8494.5 8989.7 9055.2 9323.7 522.6 562.9 574.9 578.8 579.4 4211.3 4471.7 4478.5 4505.1 4541.2 100727.0 101097.5 103371.4 142083.0 164143.0 113780.0 113867.2 119304.0 121114.8 123528.0 64814.0 66616.0 92560.6 97974.0 108955.5 9336.3 9338.3 9583.6 9772.0 9999.2 61528.7 63032.7 64266.7 64861.0 65554.0 91233.1 96233.5 98832.5 101509.0 101650.5 12165.5 12342.4 12573.4 12857.4 12898.2 13864.9 14531.9 14821.4 15251.7 15422.3 13181.4 13236.1 13448.4 13949.9 14152.9 12574.7 13613.0 13658.7 13792.5 14221.5 12323.6 13539.6 13665.2 14097.0 14111.8 10402.7 11320.7 11364.5 11441.8 11604.4 8806.7 11217.6 11394.8 11635.2 11671.2 03:40:20 INFO - PROCESS | 1656 | -------- Summary: end -------- 03:40:20 INFO - PROCESS | 1656 | 03:40:21 INFO - TEST-INFO | 1656: exit 0 03:40:21 INFO - TEST-OK | dromaeo_css | took 1117551ms 03:40:21 INFO - TEST-START | kraken 03:40:21 INFO - operating with platform_type : mac_ 03:40:21 INFO - Initialising browser for kraken test... 03:40:21 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpp1zo2L/profile http://localhost:49279/getInfo.html) 03:40:23 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 03:40:23 INFO - PROCESS | 1689 | colorDepth:24 03:40:23 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 03:40:23 INFO - PROCESS | 1689 | __metrics 03:40:24 INFO - PROCESS | 1689 | 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" 03:40:24 INFO - PROCESS | 1689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:24 INFO - TEST-INFO | 1689: exit 0 03:40:24 INFO - Browser initialized. 03:40:24 INFO - Running cycle 1/1 for kraken test... 03:40:24 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpp1zo2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:36 INFO - PROCESS | 1691 | RSS: Main: 220086272 03:40:36 INFO - PROCESS | 1691 | 03:40:39 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:40 INFO - PROCESS | 1691 | RSS: Main: 271478784 03:40:40 INFO - PROCESS | 1691 | 03:40:43 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 03:40:43 INFO - PROCESS | 1691 | RSS: Main: 282841088 03:40:43 INFO - PROCESS | 1691 | 03:40:47 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 03:40:47 INFO - PROCESS | 1691 | RSS: Main: 378703872 03:40:47 INFO - PROCESS | 1691 | 03:40:49 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 03:40:50 INFO - PROCESS | 1691 | RSS: Main: 280952832 03:40:50 INFO - PROCESS | 1691 | 03:40:52 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:52 INFO - PROCESS | 1691 | RSS: Main: 281841664 03:40:52 INFO - PROCESS | 1691 | 03:40:55 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:56 INFO - PROCESS | 1691 | RSS: Main: 319238144 03:40:56 INFO - PROCESS | 1691 | 03:40:59 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:59 INFO - PROCESS | 1691 | RSS: Main: 318468096 03:40:59 INFO - PROCESS | 1691 | 03:41:02 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 03:41:03 INFO - PROCESS | 1691 | RSS: Main: 315486208 03:41:03 INFO - PROCESS | 1691 | 03:41:04 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:05 INFO - PROCESS | 1691 | RSS: Main: 295927808 03:41:05 INFO - PROCESS | 1691 | 03:41:07 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:07 INFO - PROCESS | 1691 | RSS: Main: 296968192 03:41:07 INFO - PROCESS | 1691 | 03:41:10 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:10 INFO - PROCESS | 1691 | RSS: Main: 303648768 03:41:10 INFO - PROCESS | 1691 | 03:41:13 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:14 INFO - PROCESS | 1691 | RSS: Main: 308011008 03:41:14 INFO - PROCESS | 1691 | 03:41:17 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:17 INFO - PROCESS | 1691 | RSS: Main: 308400128 03:41:17 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 03:41:19 INFO - PROCESS | 1691 | RSS: Main: 351477760 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | __start_tp_report 03:41:19 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 03:41:19 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 03:41:19 INFO - PROCESS | 1691 | |i|pagename|runs| 03:41:19 INFO - PROCESS | 1691 | |0;ai-astar;156;165;113;114;112;112;112;118;163;119 03:41:19 INFO - PROCESS | 1691 | |1;audio-beat-detection;144;109;108;141;106;108;109;107;138;115 03:41:19 INFO - PROCESS | 1691 | |2;audio-dft;182;183;178;184;185;185;183;184;186;184 03:41:19 INFO - PROCESS | 1691 | |3;audio-fft;80;59;58;87;60;57;58;59;81;60 03:41:19 INFO - PROCESS | 1691 | |4;audio-oscillator;83;71;95;71;67;69;92;68;69;90 03:41:19 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;95;83;87;84;86;83;88;84;89;84 03:41:19 INFO - PROCESS | 1691 | |6;imaging-darkroom;96;101;98;96;148;141;97;96;96;120 03:41:19 INFO - PROCESS | 1691 | |7;imaging-desaturate;86;86;87;85;87;86;86;86;85;86 03:41:19 INFO - PROCESS | 1691 | |8;json-parse-financial;54;52;53;55;57;57;57;56;56;56 03:41:19 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;72;67;70;77;72;70;69;73;75;72 03:41:19 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;82;82;84;84;85;81;82;82;89;86 03:41:19 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;149;149;125;144;126;149;156;161;164;139 03:41:19 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;163;162;164;163;163;163;163;166;163;169 03:41:19 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;67;81;89;87;85 03:41:19 INFO - PROCESS | 1691 | __end_tp_report 03:41:19 INFO - PROCESS | 1691 | __start_cc_report 03:41:19 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,2084 03:41:19 INFO - PROCESS | 1691 | __end_cc_report 03:41:19 INFO - PROCESS | 1691 | __startTimestamp1478518879807__endTimestamp 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | ------- Summary: start ------- 03:41:19 INFO - PROCESS | 1691 | Number of tests: 14 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:128.40 Median:118.50 stddev:22.96 (19.4%) stddev-sans-first:22.08 03:41:19 INFO - PROCESS | 1691 | Values: 156.0 165.0 113.0 114.0 112.0 112.0 112.0 118.0 163.0 119.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:112.00 stddev:15.77 (14.1%) stddev-sans-first:13.77 03:41:19 INFO - PROCESS | 1691 | Values: 144.0 109.0 108.0 141.0 106.0 108.0 109.0 107.0 138.0 115.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.22 (1.2%) stddev-sans-first:2.30 03:41:19 INFO - PROCESS | 1691 | Values: 182.0 183.0 178.0 184.0 185.0 185.0 183.0 184.0 186.0 184.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.00 stddev:11.74 (19.6%) stddev-sans-first:11.29 03:41:19 INFO - PROCESS | 1691 | Values: 80.0 59.0 58.0 87.0 60.0 57.0 58.0 59.0 81.0 60.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.00 stddev:11.22 (14.6%) stddev-sans-first:11.72 03:41:19 INFO - PROCESS | 1691 | Values: 83.0 71.0 95.0 71.0 67.0 69.0 92.0 68.0 69.0 90.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:86.50 stddev:3.71 (4.3%) stddev-sans-first:2.24 03:41:19 INFO - PROCESS | 1691 | Values: 95.0 83.0 87.0 84.0 86.0 83.0 88.0 84.0 89.0 84.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:96.00 stddev:20.20 (21.0%) stddev-sans-first:20.87 03:41:19 INFO - PROCESS | 1691 | Values: 96.0 101.0 98.0 96.0 148.0 141.0 97.0 96.0 96.0 120.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 03:41:19 INFO - PROCESS | 1691 | Values: 86.0 86.0 87.0 85.0 87.0 86.0 86.0 86.0 85.0 86.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.77 (3.2%) stddev-sans-first:1.81 03:41:19 INFO - PROCESS | 1691 | Values: 54.0 52.0 53.0 55.0 57.0 57.0 57.0 56.0 56.0 56.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:2.91 (4.0%) stddev-sans-first:3.08 03:41:19 INFO - PROCESS | 1691 | Values: 72.0 67.0 70.0 77.0 72.0 70.0 69.0 73.0 75.0 72.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.45 (2.9%) stddev-sans-first:2.52 03:41:19 INFO - PROCESS | 1691 | Values: 82.0 82.0 84.0 84.0 85.0 81.0 82.0 82.0 89.0 86.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:149.00 stddev:13.21 (8.9%) stddev-sans-first:13.97 03:41:19 INFO - PROCESS | 1691 | Values: 149.0 149.0 125.0 144.0 126.0 149.0 156.0 161.0 164.0 139.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:163.00 stddev:2.08 (1.3%) stddev-sans-first:2.18 03:41:19 INFO - PROCESS | 1691 | Values: 163.0 162.0 164.0 163.0 163.0 163.0 163.0 166.0 163.0 169.0 03:41:19 INFO - PROCESS | 1691 | 03:41:19 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:9.84 (13.3%) stddev-sans-first:10.08 03:41:19 INFO - PROCESS | 1691 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 81.0 89.0 87.0 85.0 03:41:19 INFO - PROCESS | 1691 | -------- Summary: end -------- 03:41:19 INFO - PROCESS | 1691 | 03:41:20 INFO - TEST-INFO | 1691: exit 0 03:41:20 INFO - TEST-OK | kraken | took 59260ms 03:41:20 INFO - SUITE-END | took 1176s 03:41:20 INFO - Completed test suite (00:19:37) 03:41:20 INFO - javascript benchmark 03:41:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.9835950820247, 3324.9002529924096, 3352.5306457095994, 3363.2432702641922, 3398.099503631538, 4832.0, 5666.291713535808, 5678.744456499458, 5690.203371527984, 5695.800646977352, 5631.831045068644, 5674.716264186794, 5714.028615135427, 5720.0, 5736.598438109334, 5184.559312458446, 5198.220266959967, 5208.2968799212185, 5239.816606418776, 5255.658382205163, 5130.743462826844, 5163.251328557357, 5174.586033117342, 5309.150535914255, 5341.439148889369, 5167.302414174076, 5172.560332371753, 5202.219667049935, 5248.947510524903, 5266.894662106755, 5190.403103643072, 5213.2701421800975, 5216.191490319006, 5264.105102132647, 5274.92087618686, 5121.385433747937, 5226.947730522684, 5228.47715228478, 5230.503102205284, 5260.842174734764, 5481.095619222863, 5534.391216966131, 5545.195946587723, 5608.4111168327145, 5705.315362156526, 6130.061839218042, 6211.19254496917, 6219.937800621981, 6229.190205273286, 6259.530535209878, 6208.472279856218, 6301.369863013708, 6305.022721478178, 6309.08518264849, 6314.210723659543, 5689.573282003867, 5755.568332375088, 5757.337906140764, 5758.7696492140685, 5761.5678824087945, 6257.78097766576, 6291.528135389773, 6334.3032266450655, 6344.048392741126, 6370.77702280418, 6100.298465676504, 6136.386361363828, 6141.0, 6144.2319710036245, 6154.415330543591, 6089.939100609025, 6101.542384321194, 6247.344028876993, 6271.560990730605, 6291.874162516724, 6001.669908155093, 6104.495119187285, 6116.969415152896, 6126.082987924418, 6161.322254551996, 6186.845328866814, 6205.410486003822, 6206.317305096436, 6208.875822483525, 6215.782447614311, 4830.9275360869615, 4904.656674032854, 4922.433920099163, 4928.654994150375, 4935.87660308488, 4369.994901172748, 4411.985243394038, 4428.6678499112695, 4455.710378825366, 4472.865814025585, 5711.457411545896, 5765.221695071112, 5785.768569257182, 5809.622374545641, 5860.824175274749, 6247.937520624736, 6252.406021427957, 6273.560850740496, 6285.308616052231, 6290.622562646256, 5604.467575580314, 5726.742296596663, 5815.680137592473, 5819.505342045889, 5821.2141360916585, 4550.567696068868, 5297.258383826267, 5340.519353258225, 5384.865378365494, 5408.107662235687, 6226.5641405101205, 6291.119243306032, 6292.653904035139, 6295.087212354275, 6301.369863013662, 6245.437910588069, 6278.434940855345, 6281.246250449975, 6300.621962682254, 6318.968405157945, 6228.096925945803, 6234.657093859882, 6239.656818875005, 6264.843378915381, 6303.36966303366, 6105.114758359924, 6196.535259855439, 6199.659018754011, 6214.720337584729, 6219.346968568416, 5504.504594586507, 5977.0, 6298.275698294755, 6306.180196574416, 6311.116443697978, 5871.911921321269, 5939.168516407793, 5943.702814859326, 6052.818415447544, 6092.208012958465, 5043.42000669913, 5971.104334349882, 6063.878722425615, 6139.4781443577795, 6144.924638188389, 5955.255593050869, 5962.433568810956, 5963.016102343065, 5984.790532331347, 6014.188084608521, 5908.734106965283, 6063.909041364295, 6123.2958209804665, 6134.693265336626, 6137.7851775187655, 5798.768049277982, 5814.883702326015, 5904.9704751475965, 5916.792912248051, 5932.2584676915385], "value": 5674.707850455332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.50371365636573, 510.4589135516353, 516.8501134670946, 528.3263838605777, 550.7439040846007, 29867.402651946948, 40102.0, 41065.17869642602, 41263.17473650525, 44034.33948490775, 41667.79166104173, 41686.0, 42008.57991420085, 42749.35875961863, 43218.783906080505, 8638.913610863905, 9686.903130968689, 9889.604415823394, 9917.702468925943, 9929.404235745842, 8810.691625793099, 8891.95554022229, 8897.644094236255, 8900.688475903346, 12006.979406750437, 11919.165658403916, 12239.449224784861, 12247.265164090182, 12259.141860069798, 12280.938595307056, 12229.510819567207, 12295.815562766566, 12305.876941230563, 12353.011759059254, 12354.505819767244, 12007.219530730561, 12099.032077433872, 12113.818292725617, 12113.878861211364, 12114.697132571757, 40112.997175070566, 40325.59674403277, 40445.393319099945, 40476.0, 40503.0, 3321.551590535271, 3389.5593572835373, 3434.8969530914114, 3461.498082778008, 3786.753860999026, 30598.84700576483, 30907.0, 31107.688923110705, 31459.213519661964, 32135.839320803247, 3134.984325078383, 3255.641879393265, 3283.2612662150823, 3323.8670453181844, 3338.3490219407227, 385381.0, 391669.0, 391886.0, 398158.9999999971, 404203.0, 58179.41820581825, 58450.4154958445, 58583.0, 58616.70691646515, 58662.70668646629, 34227.65772342295, 35158.64841351554, 35194.76818311347, 62367.6881615589, 62655.0, 16248.59378515523, 16651.91674041622, 16723.83276167247, 16753.832461675473, 16783.16084195785, 12776.105672603015, 12807.423665935055, 12830.67923301925, 12864.356782160854, 12875.163114397721, 16337.67324653524, 16684.83315166833, 16686.49940501787, 18840.717389239173, 19001.904990475236, 7066.787996360117, 7381.704731810667, 7597.164311925684, 7617.238276172449, 7812.453128280966, 869.3088994249587, 912.7358608327514, 942.783159873233, 1013.8884722680499, 1091.6724982505216, 25209.747902521107, 28651.42697146087, 29671.851640741657, 29809.85095074511, 30404.391912161635, 1011.3072545306488, 1056.9682909512726, 1074.537948682074, 1082.6968448834339, 1099.8295264234057, 15030.774538381933, 15470.0, 15533.068015918854, 15613.609659758597, 15760.133192674513, 713313.0, 716112.8388716046, 717637.0, 719101.0, 720157.3992130005, 44399.55600443954, 49222.0, 50107.74946125246, 56488.717556412776, 57527.71236143876, 1367.685432350565, 1378.8414332351708, 1388.187910072619, 1389.5275606293908, 1394.3446580107334, 29358.853205733834, 29454.263643409085, 30150.698493015665, 30466.84766576153, 30619.2345191372, 43824.0, 48181.759091204316, 48405.75797120992, 48461.0, 48600.270995935796, 608941.0, 617101.0, 622444.0, 622650.8867455815, 623553.0, 25955.351116222246, 26345.473090538464, 26345.86827065929, 26456.338591534597, 26480.735192647826, 45329.77335113303, 46480.070398592514, 46937.06125877531, 47425.52574474211, 47751.76124119357, 38079.0, 38482.0, 39248.01879953024, 39397.0, 40716.79641601773, 29929.0, 38089.0, 38145.80927095347, 38505.0, 40067.59932400638, 37108.6289137116, 37112.81443592765, 37232.62767372291, 37867.431988519646, 37985.0, 32325.67674323321, 33942.0, 34719.13202169865, 34797.82601086979, 34944.475832862016, 25023.87488062621, 25108.62337064982, 25537.744622553535, 25600.487990240465, 25674.358141046625], "value": 20031.258503023717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1013570463171, 368.4951616285687, 380.990475238119, 381.62219402791237, 399.2354640862748, 14936.925315373435, 15034.624134396645, 16425.014499130044, 20523.38429847103, 20902.0, 19781.307654232103, 20402.591948161065, 20930.953452327398, 20986.685199722015, 21235.345581802274, 4520.7739613019385, 5811.941880581193, 6084.878302433971, 6088.543359248052, 6090.208272924514, 5040.495950404948, 6004.0693692477735, 6031.0, 6046.0, 6060.000099983497, 5628.718564071801, 5782.0, 5984.401559844003, 5985.521158307347, 5991.370906054867, 5879.529637629001, 5913.763449462016, 5916.3787802280785, 5934.821955341346, 5944.940550594503, 4914.0, 5082.1360368737405, 5156.381234251876, 5157.432682404932, 5162.819301324474, 25951.0, 26001.869990650113, 26016.479670406676, 26052.0, 26360.8681956589, 2241.4060274027397, 2252.549490101986, 2271.3980795089315, 2283.189467738962, 2455.4475243070347, 12260.386980651021, 14441.277936103257, 14821.555353339418, 15753.527394178192, 15859.0, 1868.4768264885854, 1891.8013608571177, 1907.3229003703625, 1960.7156962240538, 2008.7288216090933, 115736.0, 122379.0, 123507.0, 125234.73826308739, 127195.36402318021, 10464.686059418078, 10593.099586535076, 10974.725631859268, 10994.34033957965, 11147.219694621299, 13614.251216183206, 13630.522931697344, 13631.182129072287, 13652.795208071886, 13660.248686322348, 7740.651670674833, 8307.961504811898, 8344.958275208706, 8695.00007499133, 8795.780105497413, 7056.329648683367, 8704.78238044054, 8752.081031491729, 8919.910800892038, 8943.463392196489, 6459.677016149268, 6587.835304117435, 6593.142891424084, 6601.273859875506, 6708.765193218214, 1871.822176893193, 1873.3536929759211, 1874.8593855460895, 1885.641728071662, 1886.2455017992638, 829.995850020746, 936.344558808823, 939.8073394954018, 1016.4358780876537, 1043.4834756795435, 20924.89537552333, 21317.893410533157, 21368.572628547343, 21373.67939480909, 21487.247946321804, 958.7986522830145, 968.7335982604699, 974.3241624406011, 996.6461906023402, 998.5007496251874, 9895.60417583303, 10853.34879907208, 10855.294405863593, 11274.436278186058, 11436.656900292837, 609773.0, 614679.1192528462, 616892.0, 626318.0, 634527.0, 88392.0, 121591.39204303922, 127614.72385276214, 139919.0, 140928.0, 960.3229723045237, 984.778424854402, 1017.2167431078028, 1072.383379556758, 1073.9248252622397, 18146.637067258318, 18292.45122646323, 19106.808931910502, 19281.516521531234, 19474.221031159163, 59051.818963619626, 60102.699486502286, 61011.38988610057, 61088.694556526934, 61372.0, 68005.65997169983, 77596.83604746046, 80985.59507202427, 82314.58842705748, 85383.0, 7970.800729981797, 8038.236367545074, 8145.185481451807, 8267.379946504156, 8333.95833020831, 11290.774184516427, 11347.411362409104, 12949.805752913902, 13050.738985220432, 13196.934015329862, 10925.726856828644, 11206.047485963785, 11333.659990200307, 11414.600488982845, 11418.771624567627, 11052.944735276273, 11106.389148596581, 11364.920332568392, 11414.942925285653, 11522.711932201426, 11487.655370338904, 11491.597794077166, 11637.825432618349, 11655.59205427806, 11674.124440666814, 8164.83670326602, 8220.753377398687, 8236.382271329794, 8255.050669173123, 8259.297959673495, 9191.0, 9354.438733676001, 11002.614908478165, 11436.0, 11492.82760758606], "value": 9767.626222981175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.7605107131787, 1499.3777582303344, 1693.3142077458633, 1853.6756067688152, 1895.1377123408859, 7709.807254818632, 8177.509349439038, 8442.07137214906, 9198.448093114417, 9245.0, 8297.1702829717, 8728.825423491542, 8920.910790892089, 8930.866037009433, 9076.410033347827, 2402.9639555406684, 2428.6721292625534, 2431.65956766052, 2432.6959130108735, 2433.0, 1754.5789010637418, 2375.1829850164636, 2413.1071503543712, 2415.915442959497, 2416.504616553611, 2006.3278801601407, 2010.3164923925863, 2148.4736239621316, 2390.3187591536416, 2398.4843258699375, 2397.9760202398015, 2400.411899084718, 2428.7449817769057, 2431.0640403444622, 2437.6709144265474, 2408.1330720940446, 2413.915512957038, 2435.585950388438, 2437.9512409751883, 2443.486867757773, 8950.14973577509, 8984.730458086267, 8987.505687187202, 9011.729648110502, 9015.143561361725, 5355.544778693816, 5433.239346491494, 5503.972480137613, 5517.862053448655, 5533.750981205855, 3510.6489351064943, 3640.4721315409383, 3701.9259614807825, 3704.1665625234377, 3717.5910649828766, 1069.2034434346463, 1093.9617113400993, 1101.0530943388678, 1115.8828323026046, 1121.030308782897, 11676.29942203462, 11958.760824783543, 11974.940125299318, 11979.520819167223, 12017.93991030048, 4725.9527404726205, 4733.414154105856, 4806.44725856524, 4920.950790492049, 4929.383827021622, 8663.436876603, 10196.745081372877, 10217.438040907822, 10221.386716797017, 10247.7438064049, 5426.348838139448, 5443.074677304789, 5453.945460545423, 5458.5087342139395, 5460.290162278958, 4849.2726091086615, 4928.112939670822, 4943.826966056171, 4972.328735620717, 4976.104301225814, 3698.3158115748674, 3898.941515877264, 3965.5439624442984, 3995.9800200998807, 4021.2560676274984, 1197.7484728207, 1213.5691829400437, 1260.5840072775961, 1271.7011502296953, 1284.5118854835102, 688.5902887781762, 807.4065561812064, 866.2544971881664, 872.3457406944791, 893.7854914820397, 5832.1834943108, 5922.496587790086, 5925.822225333247, 5983.222181116427, 6210.875782484325, 872.7818045488627, 896.6503063805121, 897.7217062710581, 913.2374467319729, 925.8889332800666, 3461.3077384522694, 3977.5624681285035, 3984.30274701926, 4111.506619205715, 4142.523609784913, 10422.009909058628, 10823.188260880466, 10990.065844403316, 11110.333379997226, 11120.99911008013, 10991.230613857113, 11137.665870023913, 11142.387168705636, 11152.944235278772, 11156.0, 8224.62989165489, 8368.53973031477, 8426.831463370698, 8454.492730436194, 8460.280876125475, 5808.419158084158, 5896.469317761422, 6006.969965150146, 6008.579399441997, 6014.699265036818, 10247.94876025645, 10296.970302969643, 10321.174306055347, 10352.896471035194, 10400.843987340348, 8465.0, 9939.254555908192, 10369.792604148026, 10447.791044179226, 10490.580376784843, 7644.847103058019, 7829.765107046797, 7831.2560306770765, 7833.216678332121, 7846.450748447553, 8327.833443330977, 8387.119352467904, 8418.747437576883, 8451.577421129043, 8464.068952415106, 6255.24937007562, 7466.0, 7508.474406791691, 7557.697692092254, 7588.165301816906, 7415.295546923249, 7489.13874904393, 7497.850042999, 7500.212477689764, 7548.5470871747875, 6884.070650462324, 7053.365197132282, 7076.929230707627, 7145.64271786419, 7151.642417879189, 4245.830166793294, 5066.594672426123, 5075.92386114216, 5102.566281865935, 5172.75853795094, 5036.420811606712, 5040.395152581714, 5066.695998240118, 5220.660657057279, 5248.343957005374], "value": 4629.999387536794, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.08019998903353, 302.0500525846215, 311.6836411042791, 314.27245925682047, 317.0346295530111, 4629.699069560476, 5133.1786914093755, 5178.249153872686, 5179.559737422314, 5455.490474381784, 4756.833510827122, 5189.652674025261, 5344.91982620261, 5349.769553002802, 5395.757190926408, 3526.629703881094, 3924.4701965234613, 4049.9595004050025, 4058.1680755445136, 4092.3452247640384, 4120.835166593332, 4170.686233836347, 4172.874813755592, 4192.454980852485, 4218.957810421903, 3403.914902127442, 3854.8650797222103, 4003.4586684126675, 4064.4309796628495, 4091.672666186698, 4030.266985196364, 4038.0, 4096.242195193899, 4120.237756015132, 4127.814248358816, 3489.773164744309, 3518.6833185013215, 3522.806245656488, 3525.2773181497732, 3533.9823300883586, 4404.317330813729, 4892.608591312686, 5321.323783008379, 5361.624686271963, 5366.624336296461, 3738.420544815531, 4617.676762626617, 4632.374629425019, 4638.304254361839, 4638.397008388922, 5634.323881134249, 5652.293463317085, 5683.630564013326, 5727.1695604137585, 5729.450394574416, 3319.55186049885, 3596.1908570571672, 3836.9040773980596, 3840.0815380310887, 3851.8844434667003, 4643.976780116078, 5624.71876406178, 5947.494462970652, 6036.185115009505, 6045.395460453963, 3618.9095272618397, 3801.125741079567, 3898.317794385971, 3924.5871486264923, 3946.1910308386714, 3116.0028790787183, 3658.670719635192, 3731.6641502264924, 3835.5013848200115, 4018.8995275118355, 3894.863679771251, 4426.535213802569, 4649.395578574764, 4721.929171062437, 4742.502037286035, 4646.953530464652, 5064.0, 5661.858453538694, 5769.278840144982, 5810.709464526842, 1146.4668928948079, 1285.1453783234044, 1330.8953568538284, 1354.1739538881275, 1361.9727605447836, 818.4761752478419, 846.1115828380299, 854.4019186569426, 879.6481407436949, 917.6742256498981, 4065.2072845794787, 4938.308636790852, 4941.505849415102, 5215.061288968022, 5371.382291036581, 5374.5700343972385, 5820.272465941757, 5867.383924687846, 5881.794137205177, 5901.970490147522, 4556.931646025312, 5132.81945152617, 5313.203019547099, 5336.306280183551, 5439.864003399867, 2715.1672620980758, 2996.2209825445543, 3099.535069739557, 3106.3476669899123, 3111.7043880831284, 5278.9208161877605, 5597.124963137313, 5737.995850726106, 5756.25168728071, 6162.599431036968, 4998.0, 5136.8715782105, 6045.939540604626, 6049.882541110576, 6078.300995385499, 5307.840764777063, 5536.944630553723, 5925.563173359441, 6085.786997455068, 6157.291911430153, 4630.0, 5032.716657252377, 5702.657840529581, 5760.366359700346, 5871.295444546682, 5132.947745712195, 5641.871625674964, 5654.180143879197, 5679.801206957736, 5710.628809127394, 5743.19089486827, 6019.819405417845, 6027.728752206073, 6033.939660603338, 6055.848603784941, 3866.7099967503113, 3887.3391523441646, 3915.4126880968083, 3941.625545573166, 3954.9406758899213, 5843.94156058434, 5925.585209035326, 5956.880862382642, 5996.481477779256, 6017.382438639206, 4433.556644335541, 4905.730184839868, 4944.244793098542, 5619.044762390322, 5810.215620891295, 4914.0, 5603.55171586264, 5667.801626943037, 5843.474087331991, 5846.239988801429, 5375.19372094189, 5420.891582168413, 5660.632058916157, 5742.454466825645, 5753.079507278815, 4487.461504619467, 4599.701019433726, 5764.827055188351, 5777.291507421438, 5790.420957904176, 5122.718250496258, 5634.32388113429, 5635.464630860061, 5638.097904335286, 5646.604737668324], "value": 4109.188122708218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.815079004064, 748.7753673897829, 768.523515420439, 789.3685051958433, 806.3670019035056, 15740.527784166465, 16491.422800201995, 16513.66972660549, 16522.504324870257, 16528.256228469716, 14773.409063637468, 14946.177960212184, 14953.47662831801, 14957.551273461786, 14969.47606833761, 654.4241067860277, 674.9561278516906, 678.575890068707, 830.0330115415549, 854.799122206281, 822.5722624235394, 846.3736834742277, 848.8854004709347, 855.1405837133672, 856.0754385263931, 911.3483859040784, 911.4121391702348, 912.2018234045211, 912.9771755706095, 913.968011119611, 903.5527413930147, 904.1320332480826, 904.8190361927608, 905.3436258712446, 905.3933864310861, 522.8875791704763, 536.8147988943847, 650.1093501902377, 669.4042302350912, 677.8102131403215, 15113.0, 15214.695706085928, 15232.771508427382, 15236.23818809055, 15243.923780381137, 13879.306034698224, 14188.006839521238, 14237.43050277998, 14404.711905761826, 14531.200783956878, 12385.256884586954, 12550.81173782394, 12663.30351830649, 12858.421371038326, 13217.471301147943, 4376.715513491645, 4525.615322697575, 4543.34121552373, 4688.156131896258, 4773.379460670126, 124433.75566244312, 126309.89520838311, 127669.0, 129787.35106324407, 129830.0, 10595.09941654968, 10985.505652245669, 11282.097432205404, 11329.320240785579, 11352.886471135183, 22874.31377058691, 22992.770072299063, 23004.884975575016, 23107.0, 23389.766102339097, 8118.959405202936, 8158.0, 8173.18268173178, 8241.093479717227, 8414.158584141536, 4368.956310436855, 4387.583179597933, 4609.884752881205, 4620.884477888079, 4719.0, 3551.733619978512, 3631.4915911772373, 3662.359087159736, 3667.7799332040163, 3675.1363429594026, 661.5270081891471, 666.6133642487346, 670.5272782688193, 674.305465370669, 686.9622170780555, 584.541135208859, 615.2125279641975, 617.3671986214166, 623.4420193926501, 629.4523764325066, 8457.942757155355, 8494.532800695897, 8989.730308090768, 9055.23030542398, 9323.72028839136, 522.6028218553851, 562.9014922388566, 574.8965186266429, 578.8089930322983, 579.4495229531962, 4211.284081706117, 4471.6646251531265, 4478.48497422794, 4505.144022635689, 4541.159885421208, 100727.0, 101097.49451252844, 103371.44942825864, 142083.0, 164143.0, 113780.0, 113867.19920119821, 119304.0, 121114.78885211212, 123528.0, 64814.0, 66616.0, 92560.61159082619, 97974.02025979792, 108955.45522272655, 9336.253099751868, 9338.319102561603, 9583.616655333988, 9771.951140244253, 9999.150072243941, 61528.69235653793, 63032.68483657552, 64266.67866660637, 64861.0, 65554.01668974874, 91233.08766912245, 96233.5188324082, 98832.51751223594, 101509.0, 101650.49174754079, 12165.513379464723, 12342.382880856101, 12573.371331433575, 12857.357132143543, 12898.161619494704, 13864.86135138676, 14531.92734036323, 14821.40714371413, 15251.694966100838, 15422.305996229972, 13181.406836692564, 13236.073474856668, 13448.394822232827, 13949.930250348683, 14152.858471415566, 12574.748505030031, 13612.979026572848, 13658.658533536742, 13792.517261896186, 14221.502247421291, 12323.630291091282, 13539.59381218565, 13665.248411337074, 14097.0, 14111.788323174955, 10402.687919362432, 11320.660380188607, 11364.54541818318, 11441.771164576829, 11604.361760103275, 8806.735797926072, 11217.55129794799, 11394.829077564009, 11635.243709158878, 11671.183017188716], "value": 7799.496131882273, "unit": "score"}], "name": "dromaeo_css", "value": 7404.260632621814, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 113.0, 114.0, 112.0, 112.0, 112.0, 118.0, 163.0, 119.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 108.0, 141.0, 106.0, 108.0, 109.0, 107.0, 138.0, 115.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 178.0, 184.0, 185.0, 185.0, 183.0, 184.0, 186.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 87.0, 60.0, 57.0, 58.0, 59.0, 81.0, 60.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 95.0, 71.0, 67.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 83.0, 87.0, 84.0, 86.0, 83.0, 88.0, 84.0, 89.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 101.0, 98.0, 96.0, 148.0, 141.0, 97.0, 96.0, 96.0, 120.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 85.0, 87.0, 86.0, 86.0, 86.0, 85.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 55.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 70.0, 77.0, 72.0, 70.0, 69.0, 73.0, 75.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 84.0, 84.0, 85.0, 81.0, 82.0, 82.0, 89.0, 86.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 125.0, 144.0, 126.0, 149.0, 156.0, 161.0, 164.0, 139.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 163.0, 163.0, 163.0, 166.0, 163.0, 169.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 81.0, 89.0, 87.0, 85.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1450.0, "alertThreshold": 2.0}]} 03:41:21 INFO - Return code: 0 03:41:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:21 INFO - # TBPL SUCCESS # 03:41:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:21 INFO - 2016-11-07 03:41:21.096 screenresolution[1695:9896] starting screenresolution argv=screenresolution get 03:41:21 INFO - 2016-11-07 03:41:21.098 screenresolution[1695:9896] Display 0: 1600x1200x32@60 03:41:21 INFO - 2016-11-07 03:41:21.105 screenresolution[1696:9900] starting screenresolution argv=screenresolution list 03:41:21 INFO - Available Modes on Display 0 03:41:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:21 INFO - Intel Iris: 03:41:21 INFO - Chipset Model: Intel Iris 03:41:21 INFO - Type: GPU 03:41:21 INFO - Bus: Built-In 03:41:21 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:21 INFO - Vendor: Intel (0x8086) 03:41:21 INFO - Device ID: 0x0a2e 03:41:21 INFO - Revision ID: 0x0009 03:41:21 INFO - Displays: 03:41:21 INFO - Display: 03:41:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:21 INFO - Display Serial Number: 1600x1200 60 03:41:21 INFO - Main Display: Yes 03:41:21 INFO - Mirror: Off 03:41:21 INFO - Online: Yes 03:41:21 INFO - Rotation: Supported 03:41:21 INFO - Return code: 0 03:41:21 INFO - Running post-action listener: _resource_record_post_action 03:41:21 INFO - [mozharness: 2016-11-07 11:41:21.346909Z] Finished run-tests step (success) 03:41:21 INFO - Running post-run listener: _resource_record_post_run 03:41:21 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 39089152; Write bytes: 665332736; Read time: 429; Write time: 2157 03:41:21 INFO - TinderboxPrint: CPU usage
53.3% 03:41:21 INFO - TinderboxPrint: I/O read bytes / time
39,089,152 / 429 03:41:21 INFO - TinderboxPrint: I/O write bytes / time
665,332,736 / 2,157 03:41:21 INFO - TinderboxPrint: CPU idle
2,259.7 (46.7%) 03:41:21 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 03:41:21 INFO - TinderboxPrint: CPU user
1,612.5 (33.3%) 03:41:21 INFO - TinderboxPrint: Swap in / out
402,468,864 / 0 03:41:21 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356600320; Write bytes: 355604480; Read time: 27433; Write time: 693 03:41:21 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37282816; Write bytes: 298734592; Read time: 359; Write time: 1432 03:41:21 INFO - Running post-run listener: _upload_blobber_files 03:41:21 INFO - Blob upload gear active. 03:41:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:41:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:41:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:41:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:22 INFO - (blobuploader) - INFO - Done attempting. 03:41:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:41:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:41:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:23 INFO - (blobuploader) - INFO - Done attempting. 03:41:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:26 INFO - (blobuploader) - INFO - Done attempting. 03:41:26 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:26 INFO - Return code: 0 03:41:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d7d2505bf4987e72708da5481aec7207046ff35fb1b2c0cfe6248159a19ac3acab6720b23461d485117b53ef260e92cb3139545b208d81bf2cb9318329f2bc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/019a32ab93804fad975cd6cb56608273be06a23146661ecc797f2277436c7906b4923c062fc133d52a658d07c37c4e0e58b5be69da66f89494985e35d40e9b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac8990de72d6f1c9d7a679a01f1818356ac6f69750389b5afdafb3407dd2f73692f7a24cba1dc911ac500262c637f57d02f10e15350c9db60dc5cddf4fe48c0d"} 03:41:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:26 INFO - Contents: 03:41:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d7d2505bf4987e72708da5481aec7207046ff35fb1b2c0cfe6248159a19ac3acab6720b23461d485117b53ef260e92cb3139545b208d81bf2cb9318329f2bc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/019a32ab93804fad975cd6cb56608273be06a23146661ecc797f2277436c7906b4923c062fc133d52a658d07c37c4e0e58b5be69da66f89494985e35d40e9b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac8990de72d6f1c9d7a679a01f1818356ac6f69750389b5afdafb3407dd2f73692f7a24cba1dc911ac500262c637f57d02f10e15350c9db60dc5cddf4fe48c0d"} 03:41:26 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:26 INFO - Copying logs to upload dir... 03:41:26 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.852131 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-07 03:41:26.277530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 03:41:26.280894) ========= 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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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/6d7d2505bf4987e72708da5481aec7207046ff35fb1b2c0cfe6248159a19ac3acab6720b23461d485117b53ef260e92cb3139545b208d81bf2cb9318329f2bc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/019a32ab93804fad975cd6cb56608273be06a23146661ecc797f2277436c7906b4923c062fc133d52a658d07c37c4e0e58b5be69da66f89494985e35d40e9b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac8990de72d6f1c9d7a679a01f1818356ac6f69750389b5afdafb3407dd2f73692f7a24cba1dc911ac500262c637f57d02f10e15350c9db60dc5cddf4fe48c0d"} build_url:https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010882 build_url: 'https://queue.taskcluster.net/v1/task/JoLjMhSYRKajVOk_QaCSmg/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/6d7d2505bf4987e72708da5481aec7207046ff35fb1b2c0cfe6248159a19ac3acab6720b23461d485117b53ef260e92cb3139545b208d81bf2cb9318329f2bc6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/019a32ab93804fad975cd6cb56608273be06a23146661ecc797f2277436c7906b4923c062fc133d52a658d07c37c4e0e58b5be69da66f89494985e35d40e9b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac8990de72d6f1c9d7a679a01f1818356ac6f69750389b5afdafb3407dd2f73692f7a24cba1dc911ac500262c637f57d02f10e15350c9db60dc5cddf4fe48c0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 03:41:26.312675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 03:41:26.312960) ========= 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.nKFfNzJB7z/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.FBoZHJlz1D/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005246 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 03:41:26.360910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 03:41:26.361178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 03:41:26.361450) ========= ========= Total master_lag: 0.17 =========