builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1478842815.32 results: success (0) buildid: 20161110204020 builduid: b34f8b6fbeeb4d998cede4f66604f68e revision: 94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.324687) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.325134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.325412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.350731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.351085) ========= 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.edKK20IyJo/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.X5oU4xfrrk/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-10 21:40:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.0M=0s 2016-11-10 21:40:15 (28.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.453267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.826865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.827181) ========= 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.edKK20IyJo/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.X5oU4xfrrk/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.026790 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:15.875573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-10 21:40:15.875906) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3 --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 94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.edKK20IyJo/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.X5oU4xfrrk/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-10 21:40:15,953 truncating revision to first 12 chars 2016-11-10 21:40:15,953 Setting DEBUG logging. 2016-11-10 21:40:15,953 attempt 1/10 2016-11-10 21:40:15,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94d52b7d3d04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 21:40:16,713 unpacking tar archive at: mozilla-aurora-94d52b7d3d04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.020580 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-10 21:40:16.918399) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:16.918721) ========= script_repo_revision: 94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:16.919164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:16.919502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 21:40:16.939754) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-10 21:40:16.940138) ========= /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.edKK20IyJo/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.X5oU4xfrrk/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:40:17 INFO - MultiFileLogger online at 20161110 21:40:17 in /builds/slave/test 21:40:17 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 21:40:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:40:17 INFO - {'append_to_log': False, 21:40:17 INFO - 'base_work_dir': '/builds/slave/test', 21:40:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:40:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:40:17 INFO - 'branch': 'Mozilla-Aurora', 21:40:17 INFO - 'buildbot_json_path': 'buildprops.json', 21:40:17 INFO - 'config_files': ('talos/mac_config.py',), 21:40:17 INFO - 'default_actions': ('clobber', 21:40:17 INFO - 'read-buildbot-config', 21:40:17 INFO - 'download-and-extract', 21:40:17 INFO - 'populate-webroot', 21:40:17 INFO - 'create-virtualenv', 21:40:17 INFO - 'install', 21:40:17 INFO - 'run-tests'), 21:40:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:40:17 INFO - 'download_minidump_stackwalk': True, 21:40:17 INFO - 'download_symbols': 'ondemand', 21:40:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:40:17 INFO - 'tooltool.py': '/tools/tooltool.py', 21:40:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:40:17 INFO - '/tools/misc-python/virtualenv.py')}, 21:40:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:40:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:40:17 INFO - 'installer_path': 'installer.exe', 21:40:17 INFO - 'log_level': 'info', 21:40:17 INFO - 'log_name': 'talos', 21:40:17 INFO - 'log_to_console': True, 21:40:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:40:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:40:17 INFO - 'opt_config_files': (), 21:40:17 INFO - 'pip_index': False, 21:40:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:40:17 INFO - 'cmd': ('bash', 21:40:17 INFO - '-c', 21:40:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:40:17 INFO - 'enabled': True, 21:40:17 INFO - 'halt_on_failure': False, 21:40:17 INFO - 'name': 'check_screen_resolution'},), 21:40:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:40:17 INFO - 'cmd': ('bash', 21:40:17 INFO - '-c', 21:40:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:40:17 INFO - 'enabled': True, 21:40:17 INFO - 'halt_on_failure': False, 21:40:17 INFO - 'name': 'check_screen_resolution'},), 21:40:17 INFO - 'run_cmd_checks_enabled': True, 21:40:17 INFO - 'sps_profile': False, 21:40:17 INFO - 'sps_profile_interval': 0, 21:40:17 INFO - 'suite': 'dromaeojs', 21:40:17 INFO - 'system_bits': '32', 21:40:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:40:17 INFO - 'title': 't-yosemite-r7-0002', 21:40:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:40:17 INFO - 'use_talos_json': True, 21:40:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:40:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:40:17 INFO - 'work_dir': 'build'} 21:40:17 INFO - [mozharness: 2016-11-11 05:40:17.158282Z] Running clobber step. 21:40:17 INFO - Running pre-action listener: _resource_record_pre_action 21:40:17 INFO - Running main action method: clobber 21:40:17 INFO - rmtree: /builds/slave/test/build 21:40:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:40:19 INFO - Running post-action listener: _resource_record_post_action 21:40:19 INFO - [mozharness: 2016-11-11 05:40:19.593328Z] Finished clobber step (success) 21:40:19 INFO - [mozharness: 2016-11-11 05:40:19.593477Z] Running read-buildbot-config step. 21:40:19 INFO - Running pre-action listener: _resource_record_pre_action 21:40:19 INFO - Running main action method: read_buildbot_config 21:40:19 INFO - Using buildbot properties: 21:40:19 INFO - { 21:40:19 INFO - "project": "", 21:40:19 INFO - "product": "firefox", 21:40:19 INFO - "script_repo_revision": "production", 21:40:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:40:19 INFO - "repository": "", 21:40:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:40:19 INFO - "buildid": "20161110204020", 21:40:19 INFO - "pgo_build": "False", 21:40:19 INFO - "basedir": "/builds/slave/test", 21:40:19 INFO - "buildnumber": 57, 21:40:19 INFO - "slavename": "t-yosemite-r7-0002", 21:40:19 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:40:19 INFO - "platform": "yosemite_r7", 21:40:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:40:19 INFO - "branch": "mozilla-aurora", 21:40:19 INFO - "repo_path": "releases/mozilla-aurora", 21:40:19 INFO - "revision": "94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3", 21:40:19 INFO - "stage_platform": "macosx64", 21:40:19 INFO - "builduid": "b34f8b6fbeeb4d998cede4f66604f68e", 21:40:19 INFO - "slavebuilddir": "test" 21:40:19 INFO - } 21:40:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:40:19 INFO - Running post-action listener: _resource_record_post_action 21:40:19 INFO - [mozharness: 2016-11-11 05:40:19.596860Z] Finished read-buildbot-config step (success) 21:40:19 INFO - [mozharness: 2016-11-11 05:40:19.596968Z] Running download-and-extract step. 21:40:19 INFO - Running pre-action listener: _resource_record_pre_action 21:40:19 INFO - Running main action method: download_and_extract 21:40:19 INFO - mkdir: /builds/slave/test/build/tests 21:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:19 INFO - trying https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:40:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/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 21:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/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 21:40:20 INFO - Downloaded 1199 bytes. 21:40:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:40:20 INFO - Using the following test package requirements: 21:40:20 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:40:20 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:40:20 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:40:20 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'jsshell-mac.zip'], 21:40:20 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:40:20 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:40:20 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:40:20 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:40:20 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:40:20 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:40:20 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:40:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:40:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:40:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:40:20 INFO - Fetch https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:40:21 INFO - Expected file size: 16423314 21:40:28 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 21:40:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:40:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:40:28 INFO - Fetch https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:40:28 INFO - Expected file size: 16423314 21:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:40:36 INFO - Expected file size: 14414089 21:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:37 INFO - trying https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:40:37 INFO - Downloading https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/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 21:40:41 INFO - Downloaded 115544286 bytes. 21:40:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:40:41 INFO - mkdir: /builds/slave/test/properties 21:40:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:40:41 INFO - Writing to file /builds/slave/test/properties/build_url 21:40:41 INFO - Contents: 21:40:41 INFO - build_url:https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:40:42 INFO - Running post-action listener: _resource_record_post_action 21:40:42 INFO - Running post-action listener: set_extra_try_arguments 21:40:42 INFO - [mozharness: 2016-11-11 05:40:42.314863Z] Finished download-and-extract step (success) 21:40:42 INFO - [mozharness: 2016-11-11 05:40:42.315001Z] Running populate-webroot step. 21:40:42 INFO - Running pre-action listener: _resource_record_pre_action 21:40:42 INFO - Running main action method: populate_webroot 21:40:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:40:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:40:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:40:42 INFO - '--tppagecycles', 21:40:42 INFO - '7'], 21:40:42 INFO - 'tests': ['tsvgm']}}, 21:40:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:40:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:40:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:40:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:40:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['damp', 'tps']}, 21:40:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'tests': ['damp', 'tps']}, 21:40:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['dromaeo_dom']}, 21:40:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:40:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['basic_compositor_video']}, 21:40:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:40:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['a11yr', 21:40:42 INFO - 'ts_paint', 21:40:42 INFO - 'tpaint', 21:40:42 INFO - 'sessionrestore', 21:40:42 INFO - 'sessionrestore_no_auto_restore', 21:40:42 INFO - 'tabpaint']}, 21:40:42 INFO - 'other-e10s': {'tests': ['a11yr', 21:40:42 INFO - 'ts_paint', 21:40:42 INFO - 'tpaint', 21:40:42 INFO - 'sessionrestore', 21:40:42 INFO - 'sessionrestore_no_auto_restore', 21:40:42 INFO - 'tabpaint']}, 21:40:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:40:42 INFO - 'ts_paint', 21:40:42 INFO - 'tpaint', 21:40:42 INFO - 'sessionrestore', 21:40:42 INFO - 'sessionrestore_no_auto_restore', 21:40:42 INFO - 'tabpaint']}, 21:40:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:40:42 INFO - 'ts_paint', 21:40:42 INFO - 'tpaint', 21:40:42 INFO - 'sessionrestore', 21:40:42 INFO - 'sessionrestore_no_auto_restore', 21:40:42 INFO - 'tabpaint']}, 21:40:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['a11yr', 21:40:42 INFO - 'ts_paint', 21:40:42 INFO - 'tpaint', 21:40:42 INFO - 'sessionrestore', 21:40:42 INFO - 'sessionrestore_no_auto_restore', 21:40:42 INFO - 'tabpaint']}, 21:40:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['a11yr', 21:40:42 INFO - 'ts_paint', 21:40:42 INFO - 'tpaint', 21:40:42 INFO - 'sessionrestore', 21:40:42 INFO - 'sessionrestore_no_auto_restore', 21:40:42 INFO - 'tabpaint']}, 21:40:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['tsvgx', 21:40:42 INFO - 'tsvgr_opacity', 21:40:42 INFO - 'tart', 21:40:42 INFO - 'tscrollx', 21:40:42 INFO - 'cart']}, 21:40:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:40:42 INFO - 'tsvgr_opacity', 21:40:42 INFO - 'tart', 21:40:42 INFO - 'tscrollx', 21:40:42 INFO - 'cart']}, 21:40:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'talos_options': ['--disable-e10s'], 21:40:42 INFO - 'tests': ['tp5o']}, 21:40:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'tests': ['tp5o']}, 21:40:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'talos_options': ['--disable-e10s', 21:40:42 INFO - '--xperf_path', 21:40:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:42 INFO - 'tests': ['tp5n']}, 21:40:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:42 INFO - 'talos_options': ['--xperf_path', 21:40:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:42 INFO - 'tests': ['tp5n']}}, 21:40:42 INFO - 'talos.zip': {'path': '', 21:40:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:40:42 INFO - Running post-action listener: _resource_record_post_action 21:40:42 INFO - [mozharness: 2016-11-11 05:40:42.333692Z] Finished populate-webroot step (success) 21:40:42 INFO - [mozharness: 2016-11-11 05:40:42.333831Z] Running create-virtualenv step. 21:40:42 INFO - Running pre-action listener: _resource_record_pre_action 21:40:42 INFO - Running main action method: create_virtualenv 21:40:42 INFO - Creating virtualenv /builds/slave/test/build/venv 21:40:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:40:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:40:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:40:42 INFO - Using real prefix '/tools/python27' 21:40:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:40:43 INFO - Installing distribute.............................................................................................................................................................................................done. 21:40:46 INFO - Installing pip.................done. 21:40:46 INFO - Return code: 0 21:40:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:46 INFO - 'HOME': '/Users/cltbld', 21:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:46 INFO - 'LOGNAME': 'cltbld', 21:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:46 INFO - 'MOZ_NO_REMOTE': '1', 21:40:46 INFO - 'NO_EM_RESTART': '1', 21:40:46 INFO - 'PAGER': '/bin/cat', 21:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:46 INFO - 'PWD': '/builds/slave/test', 21:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:46 INFO - 'SHELL': '/bin/bash', 21:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:40:46 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:46 INFO - 'USER': 'cltbld', 21:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:46 INFO - 'XPC_FLAGS': '0x0', 21:40:46 INFO - 'XPC_SERVICE_NAME': '0', 21:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:40:46 INFO - Cleaning up... 21:40:46 INFO - Return code: 0 21:40:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:46 INFO - 'HOME': '/Users/cltbld', 21:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:46 INFO - 'LOGNAME': 'cltbld', 21:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:46 INFO - 'MOZ_NO_REMOTE': '1', 21:40:46 INFO - 'NO_EM_RESTART': '1', 21:40:46 INFO - 'PAGER': '/bin/cat', 21:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:46 INFO - 'PWD': '/builds/slave/test', 21:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:46 INFO - 'SHELL': '/bin/bash', 21:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:40:46 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:46 INFO - 'USER': 'cltbld', 21:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:46 INFO - 'XPC_FLAGS': '0x0', 21:40:46 INFO - 'XPC_SERVICE_NAME': '0', 21:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:46 INFO - Downloading/unpacking psutil>=3.1.1 21:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:49 INFO - Installing collected packages: psutil 21:40:49 INFO - Running setup.py install for psutil 21:40:49 INFO - building 'psutil._psutil_osx' extension 21:40:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:40:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:40:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:40:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:40:50 INFO - building 'psutil._psutil_posix' extension 21:40:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:40:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:40:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:40:50 INFO - ^ 21:40:50 INFO - 1 warning generated. 21:40:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:40:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:50 INFO - Successfully installed psutil 21:40:50 INFO - Cleaning up... 21:40:50 INFO - Return code: 0 21:40:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:40: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 mozsystemmonitor==0.3 21:40:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:40:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:50 INFO - 'HOME': '/Users/cltbld', 21:40:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:50 INFO - 'LOGNAME': 'cltbld', 21:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:50 INFO - 'MOZ_NO_REMOTE': '1', 21:40:50 INFO - 'NO_EM_RESTART': '1', 21:40:50 INFO - 'PAGER': '/bin/cat', 21:40:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:50 INFO - 'PWD': '/builds/slave/test', 21:40:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:50 INFO - 'SHELL': '/bin/bash', 21:40:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:40:50 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:40:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:50 INFO - 'USER': 'cltbld', 21:40:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:50 INFO - 'XPC_FLAGS': '0x0', 21:40:50 INFO - 'XPC_SERVICE_NAME': '0', 21:40:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:40:53 INFO - Installing collected packages: mozsystemmonitor 21:40:53 INFO - Running setup.py install for mozsystemmonitor 21:40:53 INFO - Successfully installed mozsystemmonitor 21:40:53 INFO - Cleaning up... 21:40:54 INFO - Return code: 0 21:40:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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', '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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:40: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:40: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 jsonschema==2.5.1 21:40:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:40:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:54 INFO - 'HOME': '/Users/cltbld', 21:40:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:54 INFO - 'LOGNAME': 'cltbld', 21:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:54 INFO - 'MOZ_NO_REMOTE': '1', 21:40:54 INFO - 'NO_EM_RESTART': '1', 21:40:54 INFO - 'PAGER': '/bin/cat', 21:40:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:54 INFO - 'PWD': '/builds/slave/test', 21:40:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:54 INFO - 'SHELL': '/bin/bash', 21:40:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:40:54 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:40:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:54 INFO - 'USER': 'cltbld', 21:40:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:54 INFO - 'XPC_FLAGS': '0x0', 21:40:54 INFO - 'XPC_SERVICE_NAME': '0', 21:40:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:54 INFO - Downloading/unpacking jsonschema==2.5.1 21:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:57 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:57 INFO - warning: no files found matching '*.txt' 21:40:57 INFO - no previously-included directories found matching 'build' 21:40:57 INFO - no previously-included directories found matching 'dist' 21:40:57 INFO - no previously-included directories found matching '.git*' 21:40:57 INFO - Installing collected packages: jsonschema, functools32 21:40:57 INFO - Running setup.py install for functools32 21:40:57 INFO - warning: no files found matching '*.txt' 21:40:57 INFO - no previously-included directories found matching 'build' 21:40:57 INFO - no previously-included directories found matching 'dist' 21:40:57 INFO - no previously-included directories found matching '.git*' 21:40:57 INFO - Successfully installed jsonschema functools32 21:40:57 INFO - Cleaning up... 21:40:57 INFO - Return code: 0 21:40:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:57 INFO - 'HOME': '/Users/cltbld', 21:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:57 INFO - 'LOGNAME': 'cltbld', 21:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:57 INFO - 'MOZ_NO_REMOTE': '1', 21:40:57 INFO - 'NO_EM_RESTART': '1', 21:40:57 INFO - 'PAGER': '/bin/cat', 21:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:57 INFO - 'PWD': '/builds/slave/test', 21:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:57 INFO - 'SHELL': '/bin/bash', 21:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:40:57 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:57 INFO - 'USER': 'cltbld', 21:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:57 INFO - 'XPC_FLAGS': '0x0', 21:40:57 INFO - 'XPC_SERVICE_NAME': '0', 21:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:40:57 INFO - Cleaning up... 21:40:57 INFO - Return code: 0 21:40:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:57 INFO - 'HOME': '/Users/cltbld', 21:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:57 INFO - 'LOGNAME': 'cltbld', 21:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:57 INFO - 'MOZ_NO_REMOTE': '1', 21:40:57 INFO - 'NO_EM_RESTART': '1', 21:40:57 INFO - 'PAGER': '/bin/cat', 21:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:57 INFO - 'PWD': '/builds/slave/test', 21:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:57 INFO - 'SHELL': '/bin/bash', 21:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:40:57 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:57 INFO - 'USER': 'cltbld', 21:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:57 INFO - 'XPC_FLAGS': '0x0', 21:40:57 INFO - 'XPC_SERVICE_NAME': '0', 21:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:40: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 21:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - Downloading docopt-0.6.1.tar.gz 21:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:01 INFO - Running setup.py install for blobuploader 21:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:01 INFO - Running setup.py install for requests 21:41:02 INFO - Running setup.py install for docopt 21:41:02 INFO - Successfully installed blobuploader requests docopt 21:41:02 INFO - Cleaning up... 21:41:02 INFO - Return code: 0 21:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:02 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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:02 INFO - 'HOME': '/Users/cltbld', 21:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:02 INFO - 'LOGNAME': 'cltbld', 21:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:02 INFO - 'MOZ_NO_REMOTE': '1', 21:41:02 INFO - 'NO_EM_RESTART': '1', 21:41:02 INFO - 'PAGER': '/bin/cat', 21:41:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:02 INFO - 'PWD': '/builds/slave/test', 21:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:02 INFO - 'SHELL': '/bin/bash', 21:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:41:02 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:02 INFO - 'USER': 'cltbld', 21:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:02 INFO - 'XPC_FLAGS': '0x0', 21:41:02 INFO - 'XPC_SERVICE_NAME': '0', 21:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-qSWeIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-VPJzyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3AJGcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-9F6MEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-AfBrKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-YXzIoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-KO65fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-b4PImj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-SxJshc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:03 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8H2xyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-1wiHkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-RYIGE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-z5zTBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Rq3zy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-iiIPYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-QFl6hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:04 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-kuDgMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:04 INFO - Running setup.py install for manifestparser 21:41:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Running setup.py install for mozcrash 21:41:05 INFO - Running setup.py install for mozdebug 21:41:05 INFO - Running setup.py install for mozdevice 21:41:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozfile 21:41:05 INFO - Running setup.py install for mozhttpd 21:41:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozinfo 21:41:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozInstall 21:41:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozleak 21:41:06 INFO - Running setup.py install for mozlog 21:41:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:06 INFO - Running setup.py install for moznetwork 21:41:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:06 INFO - Running setup.py install for mozprocess 21:41:06 INFO - Running setup.py install for mozprofile 21:41:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:06 INFO - Running setup.py install for mozrunner 21:41:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:06 INFO - Running setup.py install for mozscreenshot 21:41:07 INFO - Running setup.py install for moztest 21:41:07 INFO - Running setup.py install for mozversion 21:41:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:07 INFO - Cleaning up... 21:41:07 INFO - Return code: 0 21:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:07 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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:07 INFO - 'HOME': '/Users/cltbld', 21:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:07 INFO - 'LOGNAME': 'cltbld', 21:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:07 INFO - 'MOZ_NO_REMOTE': '1', 21:41:07 INFO - 'NO_EM_RESTART': '1', 21:41:07 INFO - 'PAGER': '/bin/cat', 21:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:07 INFO - 'PWD': '/builds/slave/test', 21:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:07 INFO - 'SHELL': '/bin/bash', 21:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:41:07 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:07 INFO - 'USER': 'cltbld', 21:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:07 INFO - 'XPC_FLAGS': '0x0', 21:41:07 INFO - 'XPC_SERVICE_NAME': '0', 21:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:07 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-YiClXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:07 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-tnHaCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:07 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)) 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:07 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-bRXwkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:07 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-HbMGG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:08 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)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TpCj9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-LTPUKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-cCbqNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Ujjqwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-hoy_vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-qUaipY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UIXE6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-6dLYcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:08 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)) 21:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-yjnKRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-M6A2Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:09 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)) 21:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-I33BNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-TChWih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:09 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)) 21:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-kAnv__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:41:09 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)) 21:41:09 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)) 21:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:41:09 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)) 21:41:09 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)) 21:41:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:11 INFO - Downloading blessings-1.6.tar.gz 21:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:41:11 INFO - Installing collected packages: blessings 21:41:11 INFO - Running setup.py install for blessings 21:41:12 INFO - Successfully installed blessings 21:41:12 INFO - Cleaning up... 21:41:12 INFO - Return code: 0 21:41:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:12 INFO - Reading from file tmpfile_stdout 21:41:12 INFO - Current package versions: 21:41:12 INFO - blessings == 1.6 21:41:12 INFO - blobuploader == 1.2.4 21:41:12 INFO - docopt == 0.6.1 21:41:12 INFO - functools32 == 3.2.3-2 21:41:12 INFO - jsonschema == 2.5.1 21:41:12 INFO - manifestparser == 1.1 21:41:12 INFO - mozInstall == 1.12 21:41:12 INFO - mozcrash == 0.17 21:41:12 INFO - mozdebug == 0.1 21:41:12 INFO - mozdevice == 0.48 21:41:12 INFO - mozfile == 1.2 21:41:12 INFO - mozhttpd == 0.7 21:41:12 INFO - mozinfo == 0.9 21:41:12 INFO - mozleak == 0.1 21:41:12 INFO - mozlog == 3.4 21:41:12 INFO - moznetwork == 0.27 21:41:12 INFO - mozprocess == 0.23 21:41:12 INFO - mozprofile == 0.28 21:41:12 INFO - mozrunner == 6.12 21:41:12 INFO - mozscreenshot == 0.1 21:41:12 INFO - mozsystemmonitor == 0.3 21:41:12 INFO - moztest == 0.7 21:41:12 INFO - mozversion == 1.4 21:41:12 INFO - psutil == 3.1.1 21:41:12 INFO - requests == 1.2.3 21:41:12 INFO - wsgiref == 0.1.2 21:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:12 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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:12 INFO - 'HOME': '/Users/cltbld', 21:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:12 INFO - 'LOGNAME': 'cltbld', 21:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:12 INFO - 'MOZ_NO_REMOTE': '1', 21:41:12 INFO - 'NO_EM_RESTART': '1', 21:41:12 INFO - 'PAGER': '/bin/cat', 21:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:12 INFO - 'PWD': '/builds/slave/test', 21:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:12 INFO - 'SHELL': '/bin/bash', 21:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:41:12 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:12 INFO - 'USER': 'cltbld', 21:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:12 INFO - 'XPC_FLAGS': '0x0', 21:41:12 INFO - 'XPC_SERVICE_NAME': '0', 21:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:41:12 INFO - Cleaning up... 21:41:12 INFO - Return code: 0 21:41:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:12 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 0x102e8b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e01570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca68c9b620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, '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.edKK20IyJo/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.X5oU4xfrrk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:12 INFO - 'HOME': '/Users/cltbld', 21:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:12 INFO - 'LOGNAME': 'cltbld', 21:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:12 INFO - 'MOZ_NO_REMOTE': '1', 21:41:12 INFO - 'NO_EM_RESTART': '1', 21:41:12 INFO - 'PAGER': '/bin/cat', 21:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:12 INFO - 'PWD': '/builds/slave/test', 21:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:12 INFO - 'SHELL': '/bin/bash', 21:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:41:12 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:12 INFO - 'USER': 'cltbld', 21:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:12 INFO - 'XPC_FLAGS': '0x0', 21:41:12 INFO - 'XPC_SERVICE_NAME': '0', 21:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:41:13 INFO - Cleaning up... 21:41:13 INFO - Return code: 0 21:41:13 INFO - Running post-action listener: _resource_record_post_action 21:41:13 INFO - Running post-action listener: _start_resource_monitoring 21:41:13 INFO - Starting resource monitoring. 21:41:13 INFO - [mozharness: 2016-11-11 05:41:13.079824Z] Finished create-virtualenv step (success) 21:41:13 INFO - [mozharness: 2016-11-11 05:41:13.080827Z] Running install step. 21:41:13 INFO - Running pre-action listener: _resource_record_pre_action 21:41:13 INFO - Running main action method: install 21:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:13 INFO - Reading from file tmpfile_stdout 21:41:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:41:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:41:13 INFO - Reading from file tmpfile_stdout 21:41:13 INFO - Output received: 21:41:13 INFO - Usage: mozinstall [options] installer 21:41:13 INFO - Options: 21:41:13 INFO - -h, --help show this help message and exit 21:41:13 INFO - -d DEST, --destination=DEST 21:41:13 INFO - Directory to install application into. [default: 21:41:13 INFO - "/builds/slave/test"] 21:41:13 INFO - --app=APP Application being installed. [default: firefox] 21:41:13 INFO - mkdir: /builds/slave/test/build/application 21:41:13 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'] 21:41:13 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 21:41:45 INFO - Reading from file tmpfile_stdout 21:41:45 INFO - Output received: 21:41:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:41:45 INFO - Running post-action listener: _resource_record_post_action 21:41:45 INFO - [mozharness: 2016-11-11 05:41:45.752168Z] Finished install step (success) 21:41:45 INFO - [mozharness: 2016-11-11 05:41:45.752315Z] Running run-tests step. 21:41:45 INFO - Running pre-action listener: _resource_record_pre_action 21:41:45 INFO - Running main action method: run_tests 21:41:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:41:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:41:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:41:45 INFO - 2016-11-10 21:41:45.767 screenresolution[1642:8614] starting screenresolution argv=screenresolution get 21:41:45 INFO - 2016-11-10 21:41:45.770 screenresolution[1642:8614] Display 0: 1600x1200x32@60 21:41:45 INFO - 2016-11-10 21:41:45.775 screenresolution[1643:8616] starting screenresolution argv=screenresolution list 21:41:45 INFO - Available Modes on Display 0 21:41:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:41:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:41:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:41:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:41:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:41:46 INFO - Intel Iris: 21:41:46 INFO - Chipset Model: Intel Iris 21:41:46 INFO - Type: GPU 21:41:46 INFO - Bus: Built-In 21:41:46 INFO - VRAM (Dynamic, Max): 1536 MB 21:41:46 INFO - Vendor: Intel (0x8086) 21:41:46 INFO - Device ID: 0x0a2e 21:41:46 INFO - Revision ID: 0x0009 21:41:46 INFO - Displays: 21:41:46 INFO - Display: 21:41:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:41:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:41:46 INFO - Display Serial Number: 1600x1200 60 21:41:46 INFO - Main Display: Yes 21:41:46 INFO - Mirror: Off 21:41:46 INFO - Online: Yes 21:41:46 INFO - Rotation: Supported 21:41:46 INFO - Return code: 0 21:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:46 INFO - Python 2.7.3 21:41:46 INFO - Return code: 0 21:41:46 INFO - grabbing minidump binary from tooltool 21:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:46 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 0x102c9fd30>, '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 0x102b05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c97b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:41:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:41:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:41:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:46 INFO - Return code: 0 21:41:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:41:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:41:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:46 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/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:41:46 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/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:41:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.edKK20IyJo/Render', 21:41:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:46 INFO - 'HOME': '/Users/cltbld', 21:41:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:46 INFO - 'LOGNAME': 'cltbld', 21:41:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:46 INFO - 'MOZ_NO_REMOTE': '1', 21:41:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:46 INFO - 'NO_EM_RESTART': '1', 21:41:46 INFO - 'PAGER': '/bin/cat', 21:41:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:46 INFO - 'PWD': '/builds/slave/test', 21:41:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:46 INFO - 'SHELL': '/bin/bash', 21:41:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X5oU4xfrrk/Listeners', 21:41:46 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 21:41:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:46 INFO - 'USER': 'cltbld', 21:41:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:46 INFO - 'XPC_FLAGS': '0x0', 21:41:46 INFO - 'XPC_SERVICE_NAME': '0', 21:41:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:46 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/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:41:46 INFO - mozversion application_buildid: 20161110204020 21:41:46 INFO - mozversion application_changeset: 94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3 21:41:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:41:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:46 INFO - mozversion application_name: Firefox 21:41:46 INFO - mozversion application_remotingname: firefox-dev 21:41:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:41:46 INFO - mozversion application_vendor: Mozilla 21:41:46 INFO - mozversion application_version: 51.0a2 21:41:46 INFO - mozversion platform_buildid: 20161110204020 21:41:46 INFO - mozversion platform_changeset: 94d52b7d3d048a05f67f2c3c1736e4f1bdf5eee3 21:41:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:41:46 INFO - mozversion platform_version: 51.0a2 21:41:46 INFO - using testdate: 1478842906 21:41:46 INFO - actual date: 1478842906 21:41:46 INFO - starting webserver on 'localhost:49266' 21:41:46 INFO - SUITE-START | Running 2 tests 21:41:46 INFO - TEST-START | dromaeo_css 21:41:46 INFO - operating with platform_type : mac_ 21:41:46 INFO - Initialising browser for dromaeo_css test... 21:41:46 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpy2Y19I/profile http://localhost:49266/getInfo.html) 21:41:48 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 21:41:48 INFO - PROCESS | 1653 | colorDepth:24 21:41:48 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 21:41:48 INFO - PROCESS | 1653 | __metrics 21:41:48 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" 21:41:48 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:49 INFO - TEST-INFO | 1653: exit 0 21:41:49 INFO - Browser initialized. 21:41:49 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:49 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpy2Y19I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:01 INFO - PROCESS | 1656 | RSS: Main: 220213248 21:42:01 INFO - PROCESS | 1656 | 21:42:52 INFO - PROCESS | 1656 | 1478842972649 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] 21:45:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 21:45:06 INFO - PROCESS | 1656 | RSS: Main: 362627072 21:45:06 INFO - PROCESS | 1656 | 21:48:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 21:48:09 INFO - PROCESS | 1656 | RSS: Main: 352026624 21:48:09 INFO - PROCESS | 1656 | 21:51:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 21:51:12 INFO - PROCESS | 1656 | RSS: Main: 327151616 21:51:12 INFO - PROCESS | 1656 | 21:54:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 21:54:15 INFO - PROCESS | 1656 | RSS: Main: 324530176 21:54:15 INFO - PROCESS | 1656 | 21:57:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 21:57:19 INFO - PROCESS | 1656 | RSS: Main: 312262656 21:57:19 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 22:00:22 INFO - PROCESS | 1656 | RSS: Main: 386633728 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | __start_tp_report 22:00:22 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 22:00:22 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 22:00:22 INFO - PROCESS | 1656 | |i|pagename|runs| 22:00:22 INFO - PROCESS | 1656 | |0;dojo.html;3296.571445712058;3298.5876765404323;3335.4496508076168;3351.6313205547385;3362.008207578764;5524.226608274845;5548.278723765905;5585.692786896719;5595.804146854861;5614.101743721;5544.77820887165;5595.608307418483;5604.41153678864;5646.096624540074;5646.943530564693;5121.795128194868;5133.1786914093755;5161.741912904358;5173.767180476869;5189.247559103927;5129.846104616868;5137.511936366058;5239.816606418776;5242.6330156889035;5291.126964050927;5130.102232109384;5132.409772876111;5138.640295179339;5186.273921650972;5188.9881473112755;5159.277701121865;5163.7159956202395;5173.405058418292;5173.948260517422;5249.580033597341;5042.84871453857;5178.482151784829;5182.119039763249;5218.895622087575;5232.581393488512;5470.835874923759;5540.085885828834;5540.556755459554;5596;5599.692016939067;6090.116933044728;6138.048602466625;6143.569950103494;6186.597871138407;6195.380461953813;6083.908741368883;6150.323464418955;6165.229346331708;6185.783497577563;6190.659513726743;5610.775568977277;5624.465675760796;5747.3103227612955;5778.884422311572;5790.536757059425;6118.162361256266;6120.14317995481;6146.969265153735;6160.983437732813;6175.197224360804;6030.7286172121485;6099.969500152471;6099.969500152471;6124.326324104345;6124.785632502841;4712.787924543404;6052.878942421127;6099.939000610026;6158.507319414436;6183.196184495987;6040.637561746309;6065.787697430569;6128.17269668598;6132.5707200495535;6156.29202641693;6120.510359171256;6131.110988906584;6141.393954534099;6149.0776383542825;6157.107219453154;4895.0040526496405;4899.583535399531;4907.460179380265;4913.263010548375;4916.385451818523;4278.058827058042;4351.934720979188;4355.128974205171;4381.364702118175;4405.955940440619;5651.180578816049;5656.406077361818;5720.342160651495;5740.741666625012;5792.768289268382;6121.387861213932;6167.259928808572;6183.783567575113;6204.3795620437595;6208.81373558794;5584.329880414376;5708.40061793514;5716.971415142898;5731.254936858182;5746.339170995306;5279.498447647467;5286.7356632169;5286.762095705702;5336.759845806948;5353.544948679328;6246.531510136758;6256.374362563707;6256.5307601930945;6259.4679452246155;6277.5605707600025;6138.877222455615;6142.662153581596;6150.2927163375;6156.199694039746;6189.0097584386285;6053.788117415869;6162.537809664203;6162.722677479434;6174.598651087845;6244.843878903063;6030.396960303934;6126.908096378469;6155.261368635793;6157.891579515551;6162;5500.9823182711325;6201.0388389799655;6205.627662340274;6206.534509911865;6224.937750622617;5868.237129173351;5922.289325280994;6039.943009973325;6059.091136329585;6072.939270607238;5956.344802071855;5999.430054144849;6003.339632640494;6017.458428741435;6095.299040610386;5820.970895145497;5821.126830975219;5946.345901950868;5955.344912059583;5969.611975221596;5834.970825145847;5942.257217847769;6009.429104235091;6049.062395328731;6063.363346848518;5794.246747922743;5823.068309070529;5861.7655293787775;5889.116632505158;5970.76116955317 22:00:22 INFO - PROCESS | 1656 | |1;ext.html;483.5333902783813;507.55842417097085;520.7266185252743;527.7967982326805;530.2496966791989;30698.38603227937;31619.525707114382;32851.50722739161;42185.789071054605;43465.78267108668;43092.138157236914;43273.13453730923;43275;43347.78326108373;43367.78316108415;9748.707538773848;9919.20646348294;9931.15585175261;9943.303968722192;10008.449535275557;8727.781805454882;8921.821563568757;8923.73228803137;9868.555914983843;9996.150327222194;8959.552022398886;9013.684521041765;11893.464794084288;12184.756304873941;12207.694807629792;12072.034237261041;12140.210886292363;12155.209911355734;12165.330906800122;12181.451834667418;11831.881681183164;11866.169368144234;11870.940645296805;11875.643730688093;11885.465154068088;39963.8001809992;40293.39559906574;40327.99180020494;40402;40427;3311.9668803311897;3401.268727223634;3562.6259242779392;3714.8699795507296;3743.5507739071486;29159.85420072886;29617.815287388694;29661;31413.842930785428;31743.571539280787;3165.5884734984534;3213.775035747499;3242.91892702682;3312.5362449257123;3320.037189215149;528293;534386;535524;536704;537375;32884.342313153604;33503.497447538306;59101.70449147727;59345;59610;34919.65080349164;35181.648183517835;35189.12027199341;35207.4718879217;35247.64752352495;14782.408703651949;14921.328540215716;14941.327640256215;14951.700965980619;14959.476418325306;12657.683557911127;12733.36333183337;12743.490260389666;12762.489500420064;12773.61679149627;7230.638468076575;7703.537787732754;7708.537487750753;7764.650590723318;7800.180980997027;3065.2336915771057;3190.3938251732097;3246.0910944935454;3252.886148984774;3320.28613848019;861.6467248428114;970.9417434953925;1001.7946321004323;1029.953652085658;1072.0738207934528;29015.274618134714;32317.838410808265;32447.35105297928;32663.67336326654;33295.83352083224;1046.7958748044211;1051.1590727418036;1064.1061508332882;1096.7093720164162;1130.1015692524463;14793.704125917422;15341.386344546316;15342.769858452131;15706.528804135894;15708.21458927049;745174;750984;754965;1043791;1048835;47217.29174062392;50261.497385026414;51336.74331628318;58916.70541647264;59761.40238597646;1373.2241283674691;1387.5559820857432;1405.7961595568586;1406.339020660288;1410.8448070712418;29698.851505742332;30367;30591.2352191197;30734.231644209074;31194.220144495663;48313;51351.48648513616;51355.74322128366;51430;51632.96734065223;656362;678961.6051919708;692173;692756;946985;41012.58987410207;41700.79149604232;42183.156336873704;42222.57777422186;42407;37867.81066094652;45578.77210613926;45691.77154114341;45765.31352029789;45910;37848.64740554871;38132.6186738129;38427;38736.418953715154;38745.806270969595;36505;37756.43365349467;37889.05277368088;39127;39201.41197881977;36555.634443655224;37218.25563488769;37612.62387376201;38123.80938095292;38192.61807381891;32589;33423.156337020584;34032.48951265684;34166;34641.82679086588;25151.993920242985;25282.241532754048;25440.36373223474;25474.490510190062;25518.617220742075 22:00:22 INFO - PROCESS | 1656 | |2;jquery.html;349.86530185878433;352.6138877928667;357.9212573233888;374.45142865701723;402.47878996699274;14555.417783288669;15140.621484462894;19831.603367932632;20563.28028519002;21537.784622153773;19906.800931990674;20172.39482815518;20245.291414800486;20423.59152816943;20912.849793261365;5551.861203469905;6075.513958883279;6134.079888016789;6134.723937422827;6146.6312021278645;4138.234426631067;4341.7177883437635;4391.846285380012;5363.436839131874;5960.7019649017375;6580.901286480706;6586;6681.899771503431;6689.464842812587;6692.063111164441;5814.796482123126;6554.344565543455;6572.737090516373;6704.731810727565;6768.458523318122;5837.153612726131;5842.123681447774;5844.678542680151;5845.766169353221;5847.766089356421;13164.078514503988;13417.530386436525;23562.586244825194;23912.28263152091;24988.750112499005;2198.4613769626544;2251.3020963501203;2457.6436416719653;2614.9869250653815;2958.6092058835243;9804.65683701067;9987.500624968723;10261;10293.691189264258;10334.689959301233;1851.7407562941198;1920.155131742043;1922.3944457495843;1933.2170470959143;1939.660559402099;110107;118818.40590797077;125227.99999999908;129417;130209.04686429711;9380.906190938003;9730.416175029379;10028.047335503115;10091.243156763272;10215.642452514126;12895.16181448203;13313.866861331262;13448.731025379439;14009.649758756113;14013.439462421593;8419.242268195892;8515.233628973423;8594.742157735152;8671.176238257356;8707.521086340186;8307.127751586117;8392.916070839214;8394.958025209957;8666.306695464347;8683.392162548562;4066.369712694537;4474.172278128557;4498.617617502549;4570.268756998931;4656.627469802408;1899.5915878086278;1918.6162767446287;1956.7749708783388;1984.2063174730224;1997.550551125985;702.9806780168776;888.5512816027865;942.5334459442482;970.7233438470003;980.9215262778961;20405.387838364575;21174.576508469745;21259.149634014775;21271.78728212729;21304.467388315417;884.8141890203001;937.4890684576922;960.4861399151561;962.3504134709183;963.3401120232663;10416.010479004482;11235.887641123647;11328.32030078198;11342.262752921033;11374.090072794157;600262;601471.992640034;601672;602375;616432;127649;130288;131606.34196828955;137581;139368;979.397670432693;992.2508506077864;1021.1218352217087;1021.8722659667542;1021.9080282774586;15601.765973510179;17751;18316.450506484827;18364.908175459037;18903;52138.47861521488;52418.475815241356;52876;53083;54378.728106359216;74520.50958980898;75778.62110689412;78322.4335513298;79061.60469197617;81272.7809082876;11244.381559014006;12209.69475763113;12376.319302438453;12428.254304741744;12958.028147889134;11306.321620702784;13995.790063148857;14019.859801402263;14549.636259093608;14586.635334116732;11684.532618695157;11732.061435085003;11759.76480470403;11960.521579136737;12233.877661223274;10728.356298622108;11262.93002164793;11771;12169.69575760613;12184.20802647825;11726.94136529312;11820.113491488;11920.582779602672;12201.51193952232;12324;12581.93709031449;12693.238405695687;12828.10203285761;12905.161164524652;12962.935185324013;5651.6043876928225;10406.583736650751;11781.587644432404;11870;11971.521139154685 22:00:22 INFO - PROCESS | 1656 | |3;mootools.html;1350.419319692533;1510.7129645367384;1544.3899659634444;1700.9829901700987;1849.6023354978677;7876.291133797957;8430.11483794202;8442.57787110645;8450.281726053285;8475.618597163128;8255.42212045157;8585;8837.425567338118;8881.733547993554;9017.458952462857;2112.3134981131116;2383.4994651123284;2393.5212957408503;2425.4785221177444;2428.077330614364;2178.292055082097;2203.2398822406244;2229.3869185973826;2231.4086767006756;2232.475368288451;2382.4520360317138;2407.350015495815;2415.0822687378773;2418.5646583614944;2426.2721183644926;2354.8233882458885;2386.653935179398;2393.9162129325564;2398.7001624796812;2405.6391541268777;2375.3705268103968;2377.738448770634;2379.0364902214633;2381.2499062795164;2381.9642705359433;8859.601317940707;8941.64233430662;8949.239314658262;8990.775230619287;9041.276697864156;4285.400043993844;4851.320815085891;5436.075867102602;5448.264484294609;5455.890882182373;3338.6494418086236;3427.8114703691285;3570.357335679577;3666.5416822897137;3674.1549443627846;1086.3427626286061;1097.7530055737475;1113.1984970820995;1120.7590368070823;1122.7024838417826;11880.524779008829;11982.64052078439;11996;12026.69933251667;12033.278003319829;4712.575868171881;4726.1020406122725;4894;4954.430240522314;4955.702657840469;10414.739631509274;10415.583376664848;10425.635102771366;10433.426161561036;10439.739006524745;5502.367227768777;5505.366882808448;5512.007838589093;5516.3380394352935;5517.2551705520045;4798.640101992364;4912.729799861042;5003.74981250936;5013.548780609763;5050.49495050492;3825.7895815729844;3853.075261937115;3914.921701565953;3933.8623148189677;3953.940690889639;1162.3607016141088;1164.976700465986;1174.7650469906052;1177.6937996120898;1178.7171078940992;725.5175308419841;913.5386629751932;924.0963614953218;937.1207806037738;952.2810278240023;5333;5835.9708201458725;5846.123081537803;6062.393760623902;6195.4424101831055;434.7978190141599;435.62753845462305;440.44064038670706;443.98890027749565;461.3172504693073;3974.6621537169085;4003.899902502461;4012.8996775080855;4024.4969378827645;4085.754854708727;9805.901940980642;10183.083522483012;10582.20633452494;11060.557577696964;11093.223474356879;10331.638392656221;10695.732606684895;10761.031507164393;10974.835377469344;11041.613543525938;8015.959920200362;8162.755117346489;8222.794430139174;8248.010238771265;8253.669853205925;5757.165211044459;6004.639721616717;6007.669578173068;6240.53196010292;6290.465310448663;9997.900020999989;10182.981701829758;10253.897461025294;10262.076413122557;10293.330933489298;9903;10265.2301077418;10401.375917444977;10425.061744443037;10529.157667386438;7114.822129446805;7179.676914538753;7181.605011724405;7185.2814718527725;7186.029885965328;8218.547979861165;8311.16888311164;8362.163783621589;8391.790205244917;8412.915870841458;7460.142083660231;7606.695732170651;7701.229877012254;7707.537547747153;7756.650950707119;7466;7496.962515187389;7507.474476786572;7559.20628334017;7670.386369090348;7086.326798954091;7095.467839911924;7155.212926577969;7171.03191069199;7195.8920616191845;4890.119778439915;4972.8756781080765;5043.747812609428;5167.948320516747;5199.272101905812;5106.719130447861;5122.820701275437;5123.129068058513;5247.370315562004;5350.8127215547265 22:00:22 INFO - PROCESS | 1656 | |4;prototype.html;301.3235286781176;301.36261806279714;311.339959286313;313.2075848104295;313.4389442897214;5054.292399064134;5273.38384620379;5294.52349288564;5339.679619222849;5359.490848369408;4351.6518678505645;5224.9100359856075;5225.425203227642;5229.339462376332;5276.8153114641;3857.9421308680394;4007.6154687960616;4019.738716983394;4040.373742069969;4097;3951.4467974483596;4038.6970977176684;4068.6745060395097;4070.084231048005;4072.226277007374;3999.880003599882;4018.7990600470007;4034.2365479646537;4037.234494371365;4042.454268673721;3387.7120444762227;4021.77880216588;4053.9797301013305;4054.2904991626347;4075.4701888754566;3129.765267604939;3268.9019329420157;3388.1868351595685;3526.770759900598;3548;4916.287138364953;4932;5129.769160387791;5178.300929374524;5210.348706411699;4632.8146874125;4633.447794988683;4654.045920586305;4660.650451216138;4672.696274742165;5529.668219906818;5569.498745112919;5593.077142271521;5601.187827764951;5610.747516361774;3543.6810687038032;3597.928041439183;3781.5042072232195;3872.9419058714143;3914.727713493126;5889.938521517477;5929.3181284152015;5936.46571808535;5939.732712027969;5940.910886336708;3561;3899.2786334528205;3907.5115610548683;3908.882733517999;3911.5697273299916;3210.908291180963;3352.5306457096026;3735.43968404736;3819.388897776342;3946.625070618287;4237.237297286518;4328.415663885398;4365.708003298294;4395.824167033283;4576.153411618795;4726.692764970266;4952.603791696655;5122.898576806005;5653.858653533694;5662.5753068520025;1262.8105784132454;1264.6269350541613;1294.249335385474;1295.1775622479793;1308.1823860087445;738.5347231244282;842.9452085614415;894.217559635319;898.6989358564954;901.940220241214;5292.92060619091;5316.149416093406;5320.388155362183;5333.173358129496;5339.252504649352;5157.538728999463;5469.726513674301;5666.6400063985175;5713.4000929902595;5741.885162296814;4936.185529387611;5358.54452371545;5448.128299472145;5449.3460784706085;5449.863753406117;2781.3741908070524;2816.8591570421395;3058.6941305869236;3072.446959547303;3079.3533357994625;5047;5839.7225082217965;5884.940270905149;5891.348892998082;5972.731227094791;5877.913340764053;5917.289925208916;5958.016927207049;5958.731857066442;5988.814082859725;5637.506060893867;5718.256626638594;5934.7922822701;5963.4334738199805;6087.726052327745;5127.2314848587;5657;5814.953308404528;5838.94161058384;5871.94128058714;4805.390194284953;5175.870603234798;5552.52803511706;5723.484886360247;5750.223719797774;5085.923711144262;5452.682609890701;5782.306123265067;5928.110783382527;6018.518518518596;3741.76521747828;3792.3363411402343;3862.4013277941963;3870.6709929656295;3875.554311254242;5369.946300537101;5846.970765146147;5850.912236316373;5853.678047707417;5860.882782344244;5325.502687636994;5549.584855861729;5606.6636001840025;5623.7821633774665;5640.633358831663;5143.768530416215;5531.944680553304;5551.333839939233;5558.555315574664;5562;4269.637080848162;4823.6382271329085;4839.564439200489;5296.099663057213;5317.059273365271;4639.675222734376;4790.568848803624;5000.374953130859;5541.889162216814;5564.33228012641;4245.426867372865;5425;5432.755526001419;5491.890162196813;5517.586181036358 22:00:22 INFO - PROCESS | 1656 | |5;yui.html;710.9893351599725;717.6268340462959;755.1806290175159;758.180961123378;824.6742536698005;15299.464518741846;15318.617034574127;16312.102834344107;16362.509124726248;16816.32734690614;14601.415943362279;15002.624934376647;15030.699386012273;15036.624084397896;15058;666.7699643622966;687.2371667449128;854.2055888024136;860.746079906426;867.3928250224836;695.3498478922224;848.0205362805968;867.4968518259426;874.903760586335;877.1272583779116;915.4004127296598;917.7246825952221;917.9311551633655;918.4443411735904;922.0687106022898;712.9037579926695;908;908.8591268353416;909.1635695160402;913.8400779863564;541.2557733116964;647.964361960092;666.9066330713704;669.8224970382853;672.6905623413236;14900.403983840633;14934.850651493454;14973.326200321011;14976.775348369783;14977.326020329112;10943.179261555415;11357.488912998851;11391.658250252505;11445.370504622242;11558.364289964049;12350.75298494034;12696.74606507874;12815.295158766265;12870.29213393263;13211.546729859709;4458.152950939311;4484.439445069366;4499.1451624191295;4522.208613492626;4687.742174180418;117001;121481;121579.35261942155;122291.38854305672;122812;9319.860202096974;10407.895921040845;10864.891351086388;10912.890871091187;11267.943660281646;20810;21022.36932892016;21130.894345528173;21149.78850211509;21219.575608487743;7908.644111015018;7926.682932682744;7942.483738556975;7963.163867793798;8085.757427277191;4251.914961700811;4329.740215587012;4372.803223854934;4412.33814927757;4609.124266389375;3471.7222622190166;3623.9637603624155;3628.32875917956;3629.8366573504254;3633.345997720383;666.9899951500731;667.786308381323;672.4217173231017;679.2155060904663;683.2927919603187;612.3539665652779;625.6058683029753;626.9749210031548;628.9339619339995;644.3942693867749;8644.135586441305;8707.91292087071;8734.22210678277;9084.273258139465;9262.16640502358;515.2863284351125;562.0557463461342;578.3378032153245;616.3527648748635;640.4623244314087;4402.845900393535;4417.933730994037;4447.755373454491;4470.418845550058;4494.685372023992;102161;104017.47991259996;135450.64549354577;173625;174259;141447;143784.5621543771;148823.2558837199;149409;149791;95091;95347;99948;117907;118153;9501.667441639509;10119.494025298853;10127.139193168663;10143.289969702346;10165.745856353651;60590;62899;64142;65622.34377656163;65677.67161164164;76061.85907211286;80872.19127808647;99676.50161749434;100199.49900250453;101934;10689.94655026751;11189.328640281608;11261.831072534082;12140.210886292363;13235.470581176645;12389.822966818138;14199.929000355345;14693.853061469248;15007.474738384104;16126.354945802506;11248.662540123809;14224.928875355557;14247.64380890486;14382.42470301218;15006.77489837675;14160.433582656578;14170.92914535462;14181.645458863612;14231.217283049118;14778.261086945824;13349.532766353132;13588.59234222975;13787.51743688966;14972.775408368665;15074.773878392052;11081.889181108085;11232.943835280772;11784.234024788362;11784.70538236551;11933.701657458632;9412.247020238501;10419.739506512398;10511.833788606582;10666.626668066581;10798.622048228275 22:00:22 INFO - PROCESS | 1656 | __end_tp_report 22:00:22 INFO - PROCESS | 1656 | __start_cc_report 22:00:22 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1282 22:00:22 INFO - PROCESS | 1656 | __end_cc_report 22:00:22 INFO - PROCESS | 1656 | __startTimestamp1478844022873__endTimestamp 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | ------- Summary: start ------- 22:00:22 INFO - PROCESS | 1656 | Number of tests: 6 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5665.41 Median:5861.77 stddev:625.31 (10.7%) stddev-sans-first:598.98 22:00:22 INFO - PROCESS | 1656 | Values: 3296.6 3298.6 3335.4 3351.6 3362.0 5524.2 5548.3 5585.7 5595.8 5614.1 5544.8 5595.6 5604.4 5646.1 5646.9 5121.8 5133.2 5161.7 5173.8 5189.2 5129.8 5137.5 5239.8 5242.6 5291.1 5130.1 5132.4 5138.6 5186.3 5189.0 5159.3 5163.7 5173.4 5173.9 5249.6 5042.8 5178.5 5182.1 5218.9 5232.6 5470.8 5540.1 5540.6 5596.0 5599.7 6090.1 6138.0 6143.6 6186.6 6195.4 6083.9 6150.3 6165.2 6185.8 6190.7 5610.8 5624.5 5747.3 5778.9 5790.5 6118.2 6120.1 6147.0 6161.0 6175.2 6030.7 6100.0 6100.0 6124.3 6124.8 4712.8 6052.9 6099.9 6158.5 6183.2 6040.6 6065.8 6128.2 6132.6 6156.3 6120.5 6131.1 6141.4 6149.1 6157.1 4895.0 4899.6 4907.5 4913.3 4916.4 4278.1 4351.9 4355.1 4381.4 4406.0 5651.2 5656.4 5720.3 5740.7 5792.8 6121.4 6167.3 6183.8 6204.4 6208.8 5584.3 5708.4 5717.0 5731.3 5746.3 5279.5 5286.7 5286.8 5336.8 5353.5 6246.5 6256.4 6256.5 6259.5 6277.6 6138.9 6142.7 6150.3 6156.2 6189.0 6053.8 6162.5 6162.7 6174.6 6244.8 6030.4 6126.9 6155.3 6157.9 6162.0 5501.0 6201.0 6205.6 6206.5 6224.9 5868.2 5922.3 6039.9 6059.1 6072.9 5956.3 5999.4 6003.3 6017.5 6095.3 5821.0 5821.1 5946.3 5955.3 5969.6 5835.0 5942.3 6009.4 6049.1 6063.4 5794.2 5823.1 5861.8 5889.1 5970.8 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:80984.68 Median:19405.14 stddev:197960.23 (1020.1%) stddev-sans-first:198423.29 22:00:22 INFO - PROCESS | 1656 | Values: 483.5 507.6 520.7 527.8 530.2 30698.4 31619.5 32851.5 42185.8 43465.8 43092.1 43273.1 43275.0 43347.8 43367.8 9748.7 9919.2 9931.2 9943.3 10008.4 8727.8 8921.8 8923.7 9868.6 9996.2 8959.6 9013.7 11893.5 12184.8 12207.7 12072.0 12140.2 12155.2 12165.3 12181.5 11831.9 11866.2 11870.9 11875.6 11885.5 39963.8 40293.4 40328.0 40402.0 40427.0 3312.0 3401.3 3562.6 3714.9 3743.6 29159.9 29617.8 29661.0 31413.8 31743.6 3165.6 3213.8 3242.9 3312.5 3320.0 528293.0 534386.0 535524.0 536704.0 537375.0 32884.3 33503.5 59101.7 59345.0 59610.0 34919.7 35181.6 35189.1 35207.5 35247.6 14782.4 14921.3 14941.3 14951.7 14959.5 12657.7 12733.4 12743.5 12762.5 12773.6 7230.6 7703.5 7708.5 7764.7 7800.2 3065.2 3190.4 3246.1 3252.9 3320.3 861.6 970.9 1001.8 1030.0 1072.1 29015.3 32317.8 32447.4 32663.7 33295.8 1046.8 1051.2 1064.1 1096.7 1130.1 14793.7 15341.4 15342.8 15706.5 15708.2 745174.0 750984.0 754965.0 1043791.0 1048835.0 47217.3 50261.5 51336.7 58916.7 59761.4 1373.2 1387.6 1405.8 1406.3 1410.8 29698.9 30367.0 30591.2 30734.2 31194.2 48313.0 51351.5 51355.7 51430.0 51633.0 656362.0 678961.6 692173.0 692756.0 946985.0 41012.6 41700.8 42183.2 42222.6 42407.0 37867.8 45578.8 45691.8 45765.3 45910.0 37848.6 38132.6 38427.0 38736.4 38745.8 36505.0 37756.4 37889.1 39127.0 39201.4 36555.6 37218.3 37612.6 38123.8 38192.6 32589.0 33423.2 34032.5 34166.0 34641.8 25152.0 25282.2 25440.4 25474.5 25518.6 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:35521.83 Median:21216.86 stddev:101054.32 (476.3%) stddev-sans-first:101303.30 22:00:22 INFO - PROCESS | 1656 | Values: 349.9 352.6 357.9 374.5 402.5 14555.4 15140.6 19831.6 20563.3 21537.8 19906.8 20172.4 20245.3 20423.6 20912.8 5551.9 6075.5 6134.1 6134.7 6146.6 4138.2 4341.7 4391.8 5363.4 5960.7 6580.9 6586.0 6681.9 6689.5 6692.1 5814.8 6554.3 6572.7 6704.7 6768.5 5837.2 5842.1 5844.7 5845.8 5847.8 13164.1 13417.5 23562.6 23912.3 24988.8 2198.5 2251.3 2457.6 2615.0 2958.6 9804.7 9987.5 10261.0 10293.7 10334.7 1851.7 1920.2 1922.4 1933.2 1939.7 110107.0 118818.4 125228.0 129417.0 130209.0 9380.9 9730.4 10028.0 10091.2 10215.6 12895.2 13313.9 13448.7 14009.6 14013.4 8419.2 8515.2 8594.7 8671.2 8707.5 8307.1 8392.9 8395.0 8666.3 8683.4 4066.4 4474.2 4498.6 4570.3 4656.6 1899.6 1918.6 1956.8 1984.2 1997.6 703.0 888.6 942.5 970.7 980.9 20405.4 21174.6 21259.1 21271.8 21304.5 884.8 937.5 960.5 962.4 963.3 10416.0 11235.9 11328.3 11342.3 11374.1 600262.0 601472.0 601672.0 602375.0 616432.0 127649.0 130288.0 131606.3 137581.0 139368.0 979.4 992.3 1021.1 1021.9 1021.9 15601.8 17751.0 18316.5 18364.9 18903.0 52138.5 52418.5 52876.0 53083.0 54378.7 74520.5 75778.6 78322.4 79061.6 81272.8 11244.4 12209.7 12376.3 12428.3 12958.0 11306.3 13995.8 14019.9 14549.6 14586.6 11684.5 11732.1 11759.8 11960.5 12233.9 10728.4 11262.9 11771.0 12169.7 12184.2 11726.9 11820.1 11920.6 12201.5 12324.0 12581.9 12693.2 12828.1 12905.2 12962.9 5651.6 10406.6 11781.6 11870.0 11971.5 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5755.82 Median:4824.98 stddev:3271.25 (67.8%) stddev-sans-first:3263.67 22:00:22 INFO - PROCESS | 1656 | Values: 1350.4 1510.7 1544.4 1701.0 1849.6 7876.3 8430.1 8442.6 8450.3 8475.6 8255.4 8585.0 8837.4 8881.7 9017.5 2112.3 2383.5 2393.5 2425.5 2428.1 2178.3 2203.2 2229.4 2231.4 2232.5 2382.5 2407.4 2415.1 2418.6 2426.3 2354.8 2386.7 2393.9 2398.7 2405.6 2375.4 2377.7 2379.0 2381.2 2382.0 8859.6 8941.6 8949.2 8990.8 9041.3 4285.4 4851.3 5436.1 5448.3 5455.9 3338.6 3427.8 3570.4 3666.5 3674.2 1086.3 1097.8 1113.2 1120.8 1122.7 11880.5 11982.6 11996.0 12026.7 12033.3 4712.6 4726.1 4894.0 4954.4 4955.7 10414.7 10415.6 10425.6 10433.4 10439.7 5502.4 5505.4 5512.0 5516.3 5517.3 4798.6 4912.7 5003.7 5013.5 5050.5 3825.8 3853.1 3914.9 3933.9 3953.9 1162.4 1165.0 1174.8 1177.7 1178.7 725.5 913.5 924.1 937.1 952.3 5333.0 5836.0 5846.1 6062.4 6195.4 434.8 435.6 440.4 444.0 461.3 3974.7 4003.9 4012.9 4024.5 4085.8 9805.9 10183.1 10582.2 11060.6 11093.2 10331.6 10695.7 10761.0 10974.8 11041.6 8016.0 8162.8 8222.8 8248.0 8253.7 5757.2 6004.6 6007.7 6240.5 6290.5 9997.9 10183.0 10253.9 10262.1 10293.3 9903.0 10265.2 10401.4 10425.1 10529.2 7114.8 7179.7 7181.6 7185.3 7186.0 8218.5 8311.2 8362.2 8391.8 8412.9 7460.1 7606.7 7701.2 7707.5 7756.7 7466.0 7497.0 7507.5 7559.2 7670.4 7086.3 7095.5 7155.2 7171.0 7195.9 4890.1 4972.9 5043.7 5167.9 5199.3 5106.7 5122.8 5123.1 5247.4 5350.8 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4539.50 Median:5150.65 stddev:1406.81 (27.3%) stddev-sans-first:1374.32 22:00:22 INFO - PROCESS | 1656 | Values: 301.3 301.4 311.3 313.2 313.4 5054.3 5273.4 5294.5 5339.7 5359.5 4351.7 5224.9 5225.4 5229.3 5276.8 3857.9 4007.6 4019.7 4040.4 4097.0 3951.4 4038.7 4068.7 4070.1 4072.2 3999.9 4018.8 4034.2 4037.2 4042.5 3387.7 4021.8 4054.0 4054.3 4075.5 3129.8 3268.9 3388.2 3526.8 3548.0 4916.3 4932.0 5129.8 5178.3 5210.3 4632.8 4633.4 4654.0 4660.7 4672.7 5529.7 5569.5 5593.1 5601.2 5610.7 3543.7 3597.9 3781.5 3872.9 3914.7 5889.9 5929.3 5936.5 5939.7 5940.9 3561.0 3899.3 3907.5 3908.9 3911.6 3210.9 3352.5 3735.4 3819.4 3946.6 4237.2 4328.4 4365.7 4395.8 4576.2 4726.7 4952.6 5122.9 5653.9 5662.6 1262.8 1264.6 1294.2 1295.2 1308.2 738.5 842.9 894.2 898.7 901.9 5292.9 5316.1 5320.4 5333.2 5339.3 5157.5 5469.7 5666.6 5713.4 5741.9 4936.2 5358.5 5448.1 5449.3 5449.9 2781.4 2816.9 3058.7 3072.4 3079.4 5047.0 5839.7 5884.9 5891.3 5972.7 5877.9 5917.3 5958.0 5958.7 5988.8 5637.5 5718.3 5934.8 5963.4 6087.7 5127.2 5657.0 5815.0 5838.9 5871.9 4805.4 5175.9 5552.5 5723.5 5750.2 5085.9 5452.7 5782.3 5928.1 6018.5 3741.8 3792.3 3862.4 3870.7 3875.6 5369.9 5847.0 5850.9 5853.7 5860.9 5325.5 5549.6 5606.7 5623.8 5640.6 5143.8 5531.9 5551.3 5558.6 5562.0 4269.6 4823.6 4839.6 5296.1 5317.1 4639.7 4790.6 5000.4 5541.9 5564.3 4245.4 5425.0 5432.8 5491.9 5517.6 22:00:22 INFO - PROCESS | 1656 | 22:00:22 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:25249.79 Median:12345.65 stddev:40976.68 (331.9%) stddev-sans-first:41050.21 22:00:22 INFO - PROCESS | 1656 | Values: 711.0 717.6 755.2 758.2 824.7 15299.5 15318.6 16312.1 16362.5 16816.3 14601.4 15002.6 15030.7 15036.6 15058.0 666.8 687.2 854.2 860.7 867.4 695.3 848.0 867.5 874.9 877.1 915.4 917.7 917.9 918.4 922.1 712.9 908.0 908.9 909.2 913.8 541.3 648.0 666.9 669.8 672.7 14900.4 14934.9 14973.3 14976.8 14977.3 10943.2 11357.5 11391.7 11445.4 11558.4 12350.8 12696.7 12815.3 12870.3 13211.5 4458.2 4484.4 4499.1 4522.2 4687.7 117001.0 121481.0 121579.4 122291.4 122812.0 9319.9 10407.9 10864.9 10912.9 11267.9 20810.0 21022.4 21130.9 21149.8 21219.6 7908.6 7926.7 7942.5 7963.2 8085.8 4251.9 4329.7 4372.8 4412.3 4609.1 3471.7 3624.0 3628.3 3629.8 3633.3 667.0 667.8 672.4 679.2 683.3 612.4 625.6 627.0 628.9 644.4 8644.1 8707.9 8734.2 9084.3 9262.2 515.3 562.1 578.3 616.4 640.5 4402.8 4417.9 4447.8 4470.4 4494.7 102161.0 104017.5 135450.6 173625.0 174259.0 141447.0 143784.6 148823.3 149409.0 149791.0 95091.0 95347.0 99948.0 117907.0 118153.0 9501.7 10119.5 10127.1 10143.3 10165.7 60590.0 62899.0 64142.0 65622.3 65677.7 76061.9 80872.2 99676.5 100199.5 101934.0 10689.9 11189.3 11261.8 12140.2 13235.5 12389.8 14199.9 14693.9 15007.5 16126.4 11248.7 14224.9 14247.6 14382.4 15006.8 14160.4 14170.9 14181.6 14231.2 14778.3 13349.5 13588.6 13787.5 14972.8 15074.8 11081.9 11232.9 11784.2 11784.7 11933.7 9412.2 10419.7 10511.8 10666.6 10798.6 22:00:22 INFO - PROCESS | 1656 | -------- Summary: end -------- 22:00:22 INFO - PROCESS | 1656 | 22:00:23 INFO - TEST-INFO | 1656: exit 0 22:00:23 INFO - TEST-OK | dromaeo_css | took 1117097ms 22:00:23 INFO - TEST-START | kraken 22:00:23 INFO - operating with platform_type : mac_ 22:00:23 INFO - Initialising browser for kraken test... 22:00:23 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpygBs3W/profile http://localhost:49266/getInfo.html) 22:00:25 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 22:00:25 INFO - PROCESS | 1662 | colorDepth:24 22:00:25 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 22:00:25 INFO - PROCESS | 1662 | __metrics 22:00:26 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:00:26 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:26 INFO - TEST-INFO | 1662: exit 0 22:00:26 INFO - Browser initialized. 22:00:26 INFO - Running cycle 1/1 for kraken test... 22:00:26 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpygBs3W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:38 INFO - PROCESS | 1663 | RSS: Main: 219885568 22:00:38 INFO - PROCESS | 1663 | 22:00:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:42 INFO - PROCESS | 1663 | RSS: Main: 270712832 22:00:42 INFO - PROCESS | 1663 | 22:00:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 22:00:45 INFO - PROCESS | 1663 | RSS: Main: 281763840 22:00:45 INFO - PROCESS | 1663 | 22:00:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 22:00:49 INFO - PROCESS | 1663 | RSS: Main: 379494400 22:00:49 INFO - PROCESS | 1663 | 22:00:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 22:00:52 INFO - PROCESS | 1663 | RSS: Main: 281645056 22:00:52 INFO - PROCESS | 1663 | 22:00:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:54 INFO - PROCESS | 1663 | RSS: Main: 282304512 22:00:54 INFO - PROCESS | 1663 | 22:00:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 22:00:58 INFO - PROCESS | 1663 | RSS: Main: 320638976 22:00:58 INFO - PROCESS | 1663 | 22:01:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:01 INFO - PROCESS | 1663 | RSS: Main: 318676992 22:01:01 INFO - PROCESS | 1663 | 22:01:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 22:01:05 INFO - PROCESS | 1663 | RSS: Main: 316497920 22:01:05 INFO - PROCESS | 1663 | 22:01:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:07 INFO - PROCESS | 1663 | RSS: Main: 292540416 22:01:07 INFO - PROCESS | 1663 | 22:01:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:01:10 INFO - PROCESS | 1663 | RSS: Main: 297553920 22:01:10 INFO - PROCESS | 1663 | 22:01:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:01:12 INFO - PROCESS | 1663 | RSS: Main: 302268416 22:01:12 INFO - PROCESS | 1663 | 22:01:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:01:16 INFO - PROCESS | 1663 | RSS: Main: 317841408 22:01:16 INFO - PROCESS | 1663 | 22:01:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:01:20 INFO - PROCESS | 1663 | RSS: Main: 311029760 22:01:20 INFO - PROCESS | 1663 | 22:01:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 22:01:22 INFO - PROCESS | 1663 | RSS: Main: 354955264 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | __start_tp_report 22:01:22 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 22:01:22 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 22:01:22 INFO - PROCESS | 1663 | |i|pagename|runs| 22:01:22 INFO - PROCESS | 1663 | |0;ai-astar;115;114;114;115;116;113;114;111;115;116 22:01:22 INFO - PROCESS | 1663 | |1;audio-beat-detection;146;107;110;170;137;135;108;107;139;107 22:01:22 INFO - PROCESS | 1663 | |2;audio-dft;255;259;213;185;184;182;184;183;183;180 22:01:22 INFO - PROCESS | 1663 | |3;audio-fft;81;60;59;88;62;58;58;60;83;59 22:01:22 INFO - PROCESS | 1663 | |4;audio-oscillator;86;68;95;70;68;70;92;68;91;121 22:01:22 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;85;87;84;88;84;88;84;87;85 22:01:22 INFO - PROCESS | 1663 | |6;imaging-darkroom;97;97;96;98;98;96;97;97;113;166 22:01:22 INFO - PROCESS | 1663 | |7;imaging-desaturate;134;138;108;87;85;85;86;83;89;84 22:01:22 INFO - PROCESS | 1663 | |8;json-parse-financial;58;54;54;52;56;55;56;57;54;56 22:01:22 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;66;80;83;75;74;71;70;72;71 22:01:22 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;86;81;83;84;84;84;79;82;81;87 22:01:22 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;140;143;151;155;139;139;143;172;137 22:01:22 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;165;164;215;220;162;163;175;220;162;162 22:01:22 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;66;66;65;68;78 22:01:22 INFO - PROCESS | 1663 | __end_tp_report 22:01:22 INFO - PROCESS | 1663 | __start_cc_report 22:01:22 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2010 22:01:22 INFO - PROCESS | 1663 | __end_cc_report 22:01:22 INFO - PROCESS | 1663 | __startTimestamp1478844082033__endTimestamp 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | ------- Summary: start ------- 22:01:22 INFO - PROCESS | 1663 | Number of tests: 14 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:1.56 22:01:22 INFO - PROCESS | 1663 | Values: 115.0 114.0 114.0 115.0 116.0 113.0 114.0 111.0 115.0 116.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:136.00 stddev:22.03 (16.2%) stddev-sans-first:22.22 22:01:22 INFO - PROCESS | 1663 | Values: 146.0 107.0 110.0 170.0 137.0 135.0 108.0 107.0 139.0 107.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:200.80 Median:184.50 stddev:31.10 (16.9%) stddev-sans-first:26.09 22:01:22 INFO - PROCESS | 1663 | Values: 255.0 259.0 213.0 185.0 184.0 182.0 184.0 183.0 183.0 180.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.00 stddev:12.04 (19.7%) stddev-sans-first:11.63 22:01:22 INFO - PROCESS | 1663 | Values: 81.0 60.0 59.0 88.0 62.0 58.0 58.0 60.0 83.0 59.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:78.00 stddev:17.50 (22.4%) stddev-sans-first:18.52 22:01:22 INFO - PROCESS | 1663 | Values: 86.0 68.0 95.0 70.0 68.0 70.0 92.0 68.0 91.0 121.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.66 (1.9%) stddev-sans-first:1.72 22:01:22 INFO - PROCESS | 1663 | Values: 87.0 85.0 87.0 84.0 88.0 84.0 88.0 84.0 87.0 85.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:97.00 stddev:21.85 (22.5%) stddev-sans-first:22.96 22:01:22 INFO - PROCESS | 1663 | Values: 97.0 97.0 96.0 98.0 98.0 96.0 97.0 97.0 113.0 166.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:85.00 stddev:21.35 (25.1%) stddev-sans-first:18.21 22:01:22 INFO - PROCESS | 1663 | Values: 134.0 138.0 108.0 87.0 85.0 85.0 86.0 83.0 89.0 84.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.75 (3.1%) stddev-sans-first:1.54 22:01:22 INFO - PROCESS | 1663 | Values: 58.0 54.0 54.0 52.0 56.0 55.0 56.0 57.0 54.0 56.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:73.00 stddev:5.62 (7.7%) stddev-sans-first:5.22 22:01:22 INFO - PROCESS | 1663 | Values: 65.0 66.0 80.0 83.0 75.0 74.0 71.0 70.0 72.0 71.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.00 stddev:2.42 (2.9%) stddev-sans-first:2.33 22:01:22 INFO - PROCESS | 1663 | Values: 86.0 81.0 83.0 84.0 84.0 84.0 79.0 82.0 81.0 87.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:143.00 stddev:10.87 (7.6%) stddev-sans-first:11.25 22:01:22 INFO - PROCESS | 1663 | Values: 139.0 140.0 143.0 151.0 155.0 139.0 139.0 143.0 172.0 137.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:170.00 stddev:26.22 (15.4%) stddev-sans-first:27.18 22:01:22 INFO - PROCESS | 1663 | Values: 165.0 164.0 215.0 220.0 162.0 163.0 175.0 220.0 162.0 162.0 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:66.50 stddev:3.78 (5.7%) stddev-sans-first:4.00 22:01:22 INFO - PROCESS | 1663 | Values: 67.0 66.0 67.0 66.0 66.0 66.0 66.0 65.0 68.0 78.0 22:01:22 INFO - PROCESS | 1663 | -------- Summary: end -------- 22:01:22 INFO - PROCESS | 1663 | 22:01:22 INFO - TEST-INFO | 1663: exit 0 22:01:22 INFO - TEST-OK | kraken | took 59498ms 22:01:22 INFO - SUITE-END | took 1176s 22:01:23 INFO - Completed test suite (00:19:36) 22:01:23 INFO - javascript benchmark 22:01:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.571445712058, 3298.5876765404323, 3335.4496508076168, 3351.6313205547385, 3362.008207578764, 5524.226608274845, 5548.278723765905, 5585.692786896719, 5595.804146854861, 5614.101743721, 5544.77820887165, 5595.608307418483, 5604.41153678864, 5646.096624540074, 5646.943530564693, 5121.795128194868, 5133.1786914093755, 5161.741912904358, 5173.767180476869, 5189.247559103927, 5129.846104616868, 5137.511936366058, 5239.816606418776, 5242.6330156889035, 5291.126964050927, 5130.102232109384, 5132.409772876111, 5138.640295179339, 5186.273921650972, 5188.9881473112755, 5159.277701121865, 5163.7159956202395, 5173.405058418292, 5173.948260517422, 5249.580033597341, 5042.84871453857, 5178.482151784829, 5182.119039763249, 5218.895622087575, 5232.581393488512, 5470.835874923759, 5540.085885828834, 5540.556755459554, 5596.0, 5599.692016939067, 6090.116933044728, 6138.048602466625, 6143.569950103494, 6186.597871138407, 6195.380461953813, 6083.908741368883, 6150.323464418955, 6165.229346331708, 6185.783497577563, 6190.659513726743, 5610.775568977277, 5624.465675760796, 5747.3103227612955, 5778.884422311572, 5790.536757059425, 6118.162361256266, 6120.14317995481, 6146.969265153735, 6160.983437732813, 6175.197224360804, 6030.7286172121485, 6099.969500152471, 6099.969500152471, 6124.326324104345, 6124.785632502841, 4712.787924543404, 6052.878942421127, 6099.939000610026, 6158.507319414436, 6183.196184495987, 6040.637561746309, 6065.787697430569, 6128.17269668598, 6132.5707200495535, 6156.29202641693, 6120.510359171256, 6131.110988906584, 6141.393954534099, 6149.0776383542825, 6157.107219453154, 4895.0040526496405, 4899.583535399531, 4907.460179380265, 4913.263010548375, 4916.385451818523, 4278.058827058042, 4351.934720979188, 4355.128974205171, 4381.364702118175, 4405.955940440619, 5651.180578816049, 5656.406077361818, 5720.342160651495, 5740.741666625012, 5792.768289268382, 6121.387861213932, 6167.259928808572, 6183.783567575113, 6204.3795620437595, 6208.81373558794, 5584.329880414376, 5708.40061793514, 5716.971415142898, 5731.254936858182, 5746.339170995306, 5279.498447647467, 5286.7356632169, 5286.762095705702, 5336.759845806948, 5353.544948679328, 6246.531510136758, 6256.374362563707, 6256.5307601930945, 6259.4679452246155, 6277.5605707600025, 6138.877222455615, 6142.662153581596, 6150.2927163375, 6156.199694039746, 6189.0097584386285, 6053.788117415869, 6162.537809664203, 6162.722677479434, 6174.598651087845, 6244.843878903063, 6030.396960303934, 6126.908096378469, 6155.261368635793, 6157.891579515551, 6162.0, 5500.9823182711325, 6201.0388389799655, 6205.627662340274, 6206.534509911865, 6224.937750622617, 5868.237129173351, 5922.289325280994, 6039.943009973325, 6059.091136329585, 6072.939270607238, 5956.344802071855, 5999.430054144849, 6003.339632640494, 6017.458428741435, 6095.299040610386, 5820.970895145497, 5821.126830975219, 5946.345901950868, 5955.344912059583, 5969.611975221596, 5834.970825145847, 5942.257217847769, 6009.429104235091, 6049.062395328731, 6063.363346848518, 5794.246747922743, 5823.068309070529, 5861.7655293787775, 5889.116632505158, 5970.76116955317], "value": 5625.848818501174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.5333902783813, 507.55842417097085, 520.7266185252743, 527.7967982326805, 530.2496966791989, 30698.38603227937, 31619.525707114382, 32851.50722739161, 42185.789071054605, 43465.78267108668, 43092.138157236914, 43273.13453730923, 43275.0, 43347.78326108373, 43367.78316108415, 9748.707538773848, 9919.20646348294, 9931.15585175261, 9943.303968722192, 10008.449535275557, 8727.781805454882, 8921.821563568757, 8923.73228803137, 9868.555914983843, 9996.150327222194, 8959.552022398886, 9013.684521041765, 11893.464794084288, 12184.756304873941, 12207.694807629792, 12072.034237261041, 12140.210886292363, 12155.209911355734, 12165.330906800122, 12181.451834667418, 11831.881681183164, 11866.169368144234, 11870.940645296805, 11875.643730688093, 11885.465154068088, 39963.8001809992, 40293.39559906574, 40327.99180020494, 40402.0, 40427.0, 3311.9668803311897, 3401.268727223634, 3562.6259242779392, 3714.8699795507296, 3743.5507739071486, 29159.85420072886, 29617.815287388694, 29661.0, 31413.842930785428, 31743.571539280787, 3165.5884734984534, 3213.775035747499, 3242.91892702682, 3312.5362449257123, 3320.037189215149, 528293.0, 534386.0, 535524.0, 536704.0, 537375.0, 32884.342313153604, 33503.497447538306, 59101.70449147727, 59345.0, 59610.0, 34919.65080349164, 35181.648183517835, 35189.12027199341, 35207.4718879217, 35247.64752352495, 14782.408703651949, 14921.328540215716, 14941.327640256215, 14951.700965980619, 14959.476418325306, 12657.683557911127, 12733.36333183337, 12743.490260389666, 12762.489500420064, 12773.61679149627, 7230.638468076575, 7703.537787732754, 7708.537487750753, 7764.650590723318, 7800.180980997027, 3065.2336915771057, 3190.3938251732097, 3246.0910944935454, 3252.886148984774, 3320.28613848019, 861.6467248428114, 970.9417434953925, 1001.7946321004323, 1029.953652085658, 1072.0738207934528, 29015.274618134714, 32317.838410808265, 32447.35105297928, 32663.67336326654, 33295.83352083224, 1046.7958748044211, 1051.1590727418036, 1064.1061508332882, 1096.7093720164162, 1130.1015692524463, 14793.704125917422, 15341.386344546316, 15342.769858452131, 15706.528804135894, 15708.21458927049, 745174.0, 750984.0, 754965.0, 1043791.0, 1048835.0, 47217.29174062392, 50261.497385026414, 51336.74331628318, 58916.70541647264, 59761.40238597646, 1373.2241283674691, 1387.5559820857432, 1405.7961595568586, 1406.339020660288, 1410.8448070712418, 29698.851505742332, 30367.0, 30591.2352191197, 30734.231644209074, 31194.220144495663, 48313.0, 51351.48648513616, 51355.74322128366, 51430.0, 51632.96734065223, 656362.0, 678961.6051919708, 692173.0, 692756.0, 946985.0, 41012.58987410207, 41700.79149604232, 42183.156336873704, 42222.57777422186, 42407.0, 37867.81066094652, 45578.77210613926, 45691.77154114341, 45765.31352029789, 45910.0, 37848.64740554871, 38132.6186738129, 38427.0, 38736.418953715154, 38745.806270969595, 36505.0, 37756.43365349467, 37889.05277368088, 39127.0, 39201.41197881977, 36555.634443655224, 37218.25563488769, 37612.62387376201, 38123.80938095292, 38192.61807381891, 32589.0, 33423.156337020584, 34032.48951265684, 34166.0, 34641.82679086588, 25151.993920242985, 25282.241532754048, 25440.36373223474, 25474.490510190062, 25518.617220742075], "value": 19414.500605472334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.86530185878433, 352.6138877928667, 357.9212573233888, 374.45142865701723, 402.47878996699274, 14555.417783288669, 15140.621484462894, 19831.603367932632, 20563.28028519002, 21537.784622153773, 19906.800931990674, 20172.39482815518, 20245.291414800486, 20423.59152816943, 20912.849793261365, 5551.861203469905, 6075.513958883279, 6134.079888016789, 6134.723937422827, 6146.6312021278645, 4138.234426631067, 4341.7177883437635, 4391.846285380012, 5363.436839131874, 5960.7019649017375, 6580.901286480706, 6586.0, 6681.899771503431, 6689.464842812587, 6692.063111164441, 5814.796482123126, 6554.344565543455, 6572.737090516373, 6704.731810727565, 6768.458523318122, 5837.153612726131, 5842.123681447774, 5844.678542680151, 5845.766169353221, 5847.766089356421, 13164.078514503988, 13417.530386436525, 23562.586244825194, 23912.28263152091, 24988.750112499005, 2198.4613769626544, 2251.3020963501203, 2457.6436416719653, 2614.9869250653815, 2958.6092058835243, 9804.65683701067, 9987.500624968723, 10261.0, 10293.691189264258, 10334.689959301233, 1851.7407562941198, 1920.155131742043, 1922.3944457495843, 1933.2170470959143, 1939.660559402099, 110107.0, 118818.40590797077, 125227.99999999908, 129417.0, 130209.04686429711, 9380.906190938003, 9730.416175029379, 10028.047335503115, 10091.243156763272, 10215.642452514126, 12895.16181448203, 13313.866861331262, 13448.731025379439, 14009.649758756113, 14013.439462421593, 8419.242268195892, 8515.233628973423, 8594.742157735152, 8671.176238257356, 8707.521086340186, 8307.127751586117, 8392.916070839214, 8394.958025209957, 8666.306695464347, 8683.392162548562, 4066.369712694537, 4474.172278128557, 4498.617617502549, 4570.268756998931, 4656.627469802408, 1899.5915878086278, 1918.6162767446287, 1956.7749708783388, 1984.2063174730224, 1997.550551125985, 702.9806780168776, 888.5512816027865, 942.5334459442482, 970.7233438470003, 980.9215262778961, 20405.387838364575, 21174.576508469745, 21259.149634014775, 21271.78728212729, 21304.467388315417, 884.8141890203001, 937.4890684576922, 960.4861399151561, 962.3504134709183, 963.3401120232663, 10416.010479004482, 11235.887641123647, 11328.32030078198, 11342.262752921033, 11374.090072794157, 600262.0, 601471.992640034, 601672.0, 602375.0, 616432.0, 127649.0, 130288.0, 131606.34196828955, 137581.0, 139368.0, 979.397670432693, 992.2508506077864, 1021.1218352217087, 1021.8722659667542, 1021.9080282774586, 15601.765973510179, 17751.0, 18316.450506484827, 18364.908175459037, 18903.0, 52138.47861521488, 52418.475815241356, 52876.0, 53083.0, 54378.728106359216, 74520.50958980898, 75778.62110689412, 78322.4335513298, 79061.60469197617, 81272.7809082876, 11244.381559014006, 12209.69475763113, 12376.319302438453, 12428.254304741744, 12958.028147889134, 11306.321620702784, 13995.790063148857, 14019.859801402263, 14549.636259093608, 14586.635334116732, 11684.532618695157, 11732.061435085003, 11759.76480470403, 11960.521579136737, 12233.877661223274, 10728.356298622108, 11262.93002164793, 11771.0, 12169.69575760613, 12184.20802647825, 11726.94136529312, 11820.113491488, 11920.582779602672, 12201.51193952232, 12324.0, 12581.93709031449, 12693.238405695687, 12828.10203285761, 12905.161164524652, 12962.935185324013, 5651.6043876928225, 10406.583736650751, 11781.587644432404, 11870.0, 11971.521139154685], "value": 9772.077963265585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.419319692533, 1510.7129645367384, 1544.3899659634444, 1700.9829901700987, 1849.6023354978677, 7876.291133797957, 8430.11483794202, 8442.57787110645, 8450.281726053285, 8475.618597163128, 8255.42212045157, 8585.0, 8837.425567338118, 8881.733547993554, 9017.458952462857, 2112.3134981131116, 2383.4994651123284, 2393.5212957408503, 2425.4785221177444, 2428.077330614364, 2178.292055082097, 2203.2398822406244, 2229.3869185973826, 2231.4086767006756, 2232.475368288451, 2382.4520360317138, 2407.350015495815, 2415.0822687378773, 2418.5646583614944, 2426.2721183644926, 2354.8233882458885, 2386.653935179398, 2393.9162129325564, 2398.7001624796812, 2405.6391541268777, 2375.3705268103968, 2377.738448770634, 2379.0364902214633, 2381.2499062795164, 2381.9642705359433, 8859.601317940707, 8941.64233430662, 8949.239314658262, 8990.775230619287, 9041.276697864156, 4285.400043993844, 4851.320815085891, 5436.075867102602, 5448.264484294609, 5455.890882182373, 3338.6494418086236, 3427.8114703691285, 3570.357335679577, 3666.5416822897137, 3674.1549443627846, 1086.3427626286061, 1097.7530055737475, 1113.1984970820995, 1120.7590368070823, 1122.7024838417826, 11880.524779008829, 11982.64052078439, 11996.0, 12026.69933251667, 12033.278003319829, 4712.575868171881, 4726.1020406122725, 4894.0, 4954.430240522314, 4955.702657840469, 10414.739631509274, 10415.583376664848, 10425.635102771366, 10433.426161561036, 10439.739006524745, 5502.367227768777, 5505.366882808448, 5512.007838589093, 5516.3380394352935, 5517.2551705520045, 4798.640101992364, 4912.729799861042, 5003.74981250936, 5013.548780609763, 5050.49495050492, 3825.7895815729844, 3853.075261937115, 3914.921701565953, 3933.8623148189677, 3953.940690889639, 1162.3607016141088, 1164.976700465986, 1174.7650469906052, 1177.6937996120898, 1178.7171078940992, 725.5175308419841, 913.5386629751932, 924.0963614953218, 937.1207806037738, 952.2810278240023, 5333.0, 5835.9708201458725, 5846.123081537803, 6062.393760623902, 6195.4424101831055, 434.7978190141599, 435.62753845462305, 440.44064038670706, 443.98890027749565, 461.3172504693073, 3974.6621537169085, 4003.899902502461, 4012.8996775080855, 4024.4969378827645, 4085.754854708727, 9805.901940980642, 10183.083522483012, 10582.20633452494, 11060.557577696964, 11093.223474356879, 10331.638392656221, 10695.732606684895, 10761.031507164393, 10974.835377469344, 11041.613543525938, 8015.959920200362, 8162.755117346489, 8222.794430139174, 8248.010238771265, 8253.669853205925, 5757.165211044459, 6004.639721616717, 6007.669578173068, 6240.53196010292, 6290.465310448663, 9997.900020999989, 10182.981701829758, 10253.897461025294, 10262.076413122557, 10293.330933489298, 9903.0, 10265.2301077418, 10401.375917444977, 10425.061744443037, 10529.157667386438, 7114.822129446805, 7179.676914538753, 7181.605011724405, 7185.2814718527725, 7186.029885965328, 8218.547979861165, 8311.16888311164, 8362.163783621589, 8391.790205244917, 8412.915870841458, 7460.142083660231, 7606.695732170651, 7701.229877012254, 7707.537547747153, 7756.650950707119, 7466.0, 7496.962515187389, 7507.474476786572, 7559.20628334017, 7670.386369090348, 7086.326798954091, 7095.467839911924, 7155.212926577969, 7171.03191069199, 7195.8920616191845, 4890.119778439915, 4972.8756781080765, 5043.747812609428, 5167.948320516747, 5199.272101905812, 5106.719130447861, 5122.820701275437, 5123.129068058513, 5247.370315562004, 5350.8127215547265], "value": 4523.633861035925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3235286781176, 301.36261806279714, 311.339959286313, 313.2075848104295, 313.4389442897214, 5054.292399064134, 5273.38384620379, 5294.52349288564, 5339.679619222849, 5359.490848369408, 4351.6518678505645, 5224.9100359856075, 5225.425203227642, 5229.339462376332, 5276.8153114641, 3857.9421308680394, 4007.6154687960616, 4019.738716983394, 4040.373742069969, 4097.0, 3951.4467974483596, 4038.6970977176684, 4068.6745060395097, 4070.084231048005, 4072.226277007374, 3999.880003599882, 4018.7990600470007, 4034.2365479646537, 4037.234494371365, 4042.454268673721, 3387.7120444762227, 4021.77880216588, 4053.9797301013305, 4054.2904991626347, 4075.4701888754566, 3129.765267604939, 3268.9019329420157, 3388.1868351595685, 3526.770759900598, 3548.0, 4916.287138364953, 4932.0, 5129.769160387791, 5178.300929374524, 5210.348706411699, 4632.8146874125, 4633.447794988683, 4654.045920586305, 4660.650451216138, 4672.696274742165, 5529.668219906818, 5569.498745112919, 5593.077142271521, 5601.187827764951, 5610.747516361774, 3543.6810687038032, 3597.928041439183, 3781.5042072232195, 3872.9419058714143, 3914.727713493126, 5889.938521517477, 5929.3181284152015, 5936.46571808535, 5939.732712027969, 5940.910886336708, 3561.0, 3899.2786334528205, 3907.5115610548683, 3908.882733517999, 3911.5697273299916, 3210.908291180963, 3352.5306457096026, 3735.43968404736, 3819.388897776342, 3946.625070618287, 4237.237297286518, 4328.415663885398, 4365.708003298294, 4395.824167033283, 4576.153411618795, 4726.692764970266, 4952.603791696655, 5122.898576806005, 5653.858653533694, 5662.5753068520025, 1262.8105784132454, 1264.6269350541613, 1294.249335385474, 1295.1775622479793, 1308.1823860087445, 738.5347231244282, 842.9452085614415, 894.217559635319, 898.6989358564954, 901.940220241214, 5292.92060619091, 5316.149416093406, 5320.388155362183, 5333.173358129496, 5339.252504649352, 5157.538728999463, 5469.726513674301, 5666.6400063985175, 5713.4000929902595, 5741.885162296814, 4936.185529387611, 5358.54452371545, 5448.128299472145, 5449.3460784706085, 5449.863753406117, 2781.3741908070524, 2816.8591570421395, 3058.6941305869236, 3072.446959547303, 3079.3533357994625, 5047.0, 5839.7225082217965, 5884.940270905149, 5891.348892998082, 5972.731227094791, 5877.913340764053, 5917.289925208916, 5958.016927207049, 5958.731857066442, 5988.814082859725, 5637.506060893867, 5718.256626638594, 5934.7922822701, 5963.4334738199805, 6087.726052327745, 5127.2314848587, 5657.0, 5814.953308404528, 5838.94161058384, 5871.94128058714, 4805.390194284953, 5175.870603234798, 5552.52803511706, 5723.484886360247, 5750.223719797774, 5085.923711144262, 5452.682609890701, 5782.306123265067, 5928.110783382527, 6018.518518518596, 3741.76521747828, 3792.3363411402343, 3862.4013277941963, 3870.6709929656295, 3875.554311254242, 5369.946300537101, 5846.970765146147, 5850.912236316373, 5853.678047707417, 5860.882782344244, 5325.502687636994, 5549.584855861729, 5606.6636001840025, 5623.7821633774665, 5640.633358831663, 5143.768530416215, 5531.944680553304, 5551.333839939233, 5558.555315574664, 5562.0, 4269.637080848162, 4823.6382271329085, 4839.564439200489, 5296.099663057213, 5317.059273365271, 4639.675222734376, 4790.568848803624, 5000.374953130859, 5541.889162216814, 5564.33228012641, 4245.426867372865, 5425.0, 5432.755526001419, 5491.890162196813, 5517.586181036358], "value": 4086.2313333997613, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9893351599725, 717.6268340462959, 755.1806290175159, 758.180961123378, 824.6742536698005, 15299.464518741846, 15318.617034574127, 16312.102834344107, 16362.509124726248, 16816.32734690614, 14601.415943362279, 15002.624934376647, 15030.699386012273, 15036.624084397896, 15058.0, 666.7699643622966, 687.2371667449128, 854.2055888024136, 860.746079906426, 867.3928250224836, 695.3498478922224, 848.0205362805968, 867.4968518259426, 874.903760586335, 877.1272583779116, 915.4004127296598, 917.7246825952221, 917.9311551633655, 918.4443411735904, 922.0687106022898, 712.9037579926695, 908.0, 908.8591268353416, 909.1635695160402, 913.8400779863564, 541.2557733116964, 647.964361960092, 666.9066330713704, 669.8224970382853, 672.6905623413236, 14900.403983840633, 14934.850651493454, 14973.326200321011, 14976.775348369783, 14977.326020329112, 10943.179261555415, 11357.488912998851, 11391.658250252505, 11445.370504622242, 11558.364289964049, 12350.75298494034, 12696.74606507874, 12815.295158766265, 12870.29213393263, 13211.546729859709, 4458.152950939311, 4484.439445069366, 4499.1451624191295, 4522.208613492626, 4687.742174180418, 117001.0, 121481.0, 121579.35261942155, 122291.38854305672, 122812.0, 9319.860202096974, 10407.895921040845, 10864.891351086388, 10912.890871091187, 11267.943660281646, 20810.0, 21022.36932892016, 21130.894345528173, 21149.78850211509, 21219.575608487743, 7908.644111015018, 7926.682932682744, 7942.483738556975, 7963.163867793798, 8085.757427277191, 4251.914961700811, 4329.740215587012, 4372.803223854934, 4412.33814927757, 4609.124266389375, 3471.7222622190166, 3623.9637603624155, 3628.32875917956, 3629.8366573504254, 3633.345997720383, 666.9899951500731, 667.786308381323, 672.4217173231017, 679.2155060904663, 683.2927919603187, 612.3539665652779, 625.6058683029753, 626.9749210031548, 628.9339619339995, 644.3942693867749, 8644.135586441305, 8707.91292087071, 8734.22210678277, 9084.273258139465, 9262.16640502358, 515.2863284351125, 562.0557463461342, 578.3378032153245, 616.3527648748635, 640.4623244314087, 4402.845900393535, 4417.933730994037, 4447.755373454491, 4470.418845550058, 4494.685372023992, 102161.0, 104017.47991259996, 135450.64549354577, 173625.0, 174259.0, 141447.0, 143784.5621543771, 148823.2558837199, 149409.0, 149791.0, 95091.0, 95347.0, 99948.0, 117907.0, 118153.0, 9501.667441639509, 10119.494025298853, 10127.139193168663, 10143.289969702346, 10165.745856353651, 60590.0, 62899.0, 64142.0, 65622.34377656163, 65677.67161164164, 76061.85907211286, 80872.19127808647, 99676.50161749434, 100199.49900250453, 101934.0, 10689.94655026751, 11189.328640281608, 11261.831072534082, 12140.210886292363, 13235.470581176645, 12389.822966818138, 14199.929000355345, 14693.853061469248, 15007.474738384104, 16126.354945802506, 11248.662540123809, 14224.928875355557, 14247.64380890486, 14382.42470301218, 15006.77489837675, 14160.433582656578, 14170.92914535462, 14181.645458863612, 14231.217283049118, 14778.261086945824, 13349.532766353132, 13588.59234222975, 13787.51743688966, 14972.775408368665, 15074.773878392052, 11081.889181108085, 11232.943835280772, 11784.234024788362, 11784.70538236551, 11933.701657458632, 9412.247020238501, 10419.739506512398, 10511.833788606582, 10666.626668066581, 10798.622048228275], "value": 7816.018596247066, "unit": "score"}], "name": "dromaeo_css", "value": 7323.0252809337035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 116.0, 113.0, 114.0, 111.0, 115.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 110.0, 170.0, 137.0, 135.0, 108.0, 107.0, 139.0, 107.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [255.0, 259.0, 213.0, 185.0, 184.0, 182.0, 184.0, 183.0, 183.0, 180.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 88.0, 62.0, 58.0, 58.0, 60.0, 83.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 68.0, 95.0, 70.0, 68.0, 70.0, 92.0, 68.0, 91.0, 121.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 88.0, 84.0, 88.0, 84.0, 87.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 98.0, 98.0, 96.0, 97.0, 97.0, 113.0, 166.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 108.0, 87.0, 85.0, 85.0, 86.0, 83.0, 89.0, 84.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 52.0, 56.0, 55.0, 56.0, 57.0, 54.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 80.0, 83.0, 75.0, 74.0, 71.0, 70.0, 72.0, 71.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 83.0, 84.0, 84.0, 84.0, 79.0, 82.0, 81.0, 87.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 143.0, 151.0, 155.0, 139.0, 139.0, 143.0, 172.0, 137.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 215.0, 220.0, 162.0, 163.0, 175.0, 220.0, 162.0, 162.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 68.0, 78.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1485.8, "alertThreshold": 2.0}]} 22:01:23 INFO - Return code: 0 22:01:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:01:23 INFO - # TBPL SUCCESS # 22:01:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:01:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:01:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:01:23 INFO - 2016-11-10 22:01:23.347 screenresolution[1667:10918] starting screenresolution argv=screenresolution get 22:01:23 INFO - 2016-11-10 22:01:23.350 screenresolution[1667:10918] Display 0: 1600x1200x32@60 22:01:23 INFO - 2016-11-10 22:01:23.357 screenresolution[1668:10921] starting screenresolution argv=screenresolution list 22:01:23 INFO - Available Modes on Display 0 22:01:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:01:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:01:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:01:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:01:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:01:23 INFO - Intel Iris: 22:01:23 INFO - Chipset Model: Intel Iris 22:01:23 INFO - Type: GPU 22:01:23 INFO - Bus: Built-In 22:01:23 INFO - VRAM (Dynamic, Max): 1536 MB 22:01:23 INFO - Vendor: Intel (0x8086) 22:01:23 INFO - Device ID: 0x0a2e 22:01:23 INFO - Revision ID: 0x0009 22:01:23 INFO - Displays: 22:01:23 INFO - Display: 22:01:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:01:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:01:23 INFO - Display Serial Number: 1600x1200 60 22:01:23 INFO - Main Display: Yes 22:01:23 INFO - Mirror: Off 22:01:23 INFO - Online: Yes 22:01:23 INFO - Rotation: Supported 22:01:23 INFO - Return code: 0 22:01:23 INFO - Running post-action listener: _resource_record_post_action 22:01:23 INFO - [mozharness: 2016-11-11 06:01:23.594097Z] Finished run-tests step (success) 22:01:23 INFO - Running post-run listener: _resource_record_post_run 22:01:23 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 33364992; Write bytes: 665180672; Read time: 312; Write time: 2022 22:01:23 INFO - TinderboxPrint: CPU usage
53.6% 22:01:23 INFO - TinderboxPrint: I/O read bytes / time
33,364,992 / 312 22:01:23 INFO - TinderboxPrint: I/O write bytes / time
665,180,672 / 2,022 22:01:23 INFO - TinderboxPrint: CPU idle
2,248.7 (46.4%) 22:01:23 INFO - TinderboxPrint: CPU system
973.6 (20.1%) 22:01:23 INFO - TinderboxPrint: CPU user
1,619.5 (33.4%) 22:01:23 INFO - TinderboxPrint: Swap in / out
393,445,376 / 0 22:01:23 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356747776; Write bytes: 357180928; Read time: 27537; Write time: 713 22:01:23 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31595520; Write bytes: 297001984; Read time: 294; Write time: 1272 22:01:24 INFO - Running post-run listener: _upload_blobber_files 22:01:24 INFO - Blob upload gear active. 22:01:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:01:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:01:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:01:24 INFO - (blobuploader) - INFO - Open directory for files ... 22:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:01:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:25 INFO - (blobuploader) - INFO - Done attempting. 22:01:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:01:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:01:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:26 INFO - (blobuploader) - INFO - Done attempting. 22:01:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:01:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:01:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:28 INFO - (blobuploader) - INFO - Done attempting. 22:01:28 INFO - (blobuploader) - INFO - Iteration through files over. 22:01:28 INFO - Return code: 0 22:01:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:01:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:01:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3d083170cdb6b6e4b1a0ec47df32e77f32d0f2b87cebac79c96bf2fc03bc117e85829208118a51dbdbb98321b73dc76ffceaa976769f8c0d3ed428649cb4213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42cddb7e02c28c10c9a45096ddecfe0ef59da95df904493a98c289d3a4ef8582cd58a1b6f888c34ca6acca1515d0f05404d4a5c36cdab0502afcf10f821c01a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d93514a6f1525684ad372a2ab2b18cce5dde713c3993a198ab54351f6d54226a7bc38e1a421047403f98b5b0892cf5ee97a759fe7b8708672d26aece5af0748"} 22:01:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:01:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:01:28 INFO - Contents: 22:01:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3d083170cdb6b6e4b1a0ec47df32e77f32d0f2b87cebac79c96bf2fc03bc117e85829208118a51dbdbb98321b73dc76ffceaa976769f8c0d3ed428649cb4213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42cddb7e02c28c10c9a45096ddecfe0ef59da95df904493a98c289d3a4ef8582cd58a1b6f888c34ca6acca1515d0f05404d4a5c36cdab0502afcf10f821c01a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d93514a6f1525684ad372a2ab2b18cce5dde713c3993a198ab54351f6d54226a7bc38e1a421047403f98b5b0892cf5ee97a759fe7b8708672d26aece5af0748"} 22:01:28 INFO - Running post-run listener: copy_logs_to_upload_dir 22:01:28 INFO - Copying logs to upload dir... 22:01:28 INFO - mkdir: /builds/slave/test/build/upload/logs 22:01:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.876749 ========= master_lag: 0.58 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-10 22:01:29.396010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 22:01:29.397239) ========= 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.edKK20IyJo/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.X5oU4xfrrk/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/b3d083170cdb6b6e4b1a0ec47df32e77f32d0f2b87cebac79c96bf2fc03bc117e85829208118a51dbdbb98321b73dc76ffceaa976769f8c0d3ed428649cb4213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42cddb7e02c28c10c9a45096ddecfe0ef59da95df904493a98c289d3a4ef8582cd58a1b6f888c34ca6acca1515d0f05404d4a5c36cdab0502afcf10f821c01a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d93514a6f1525684ad372a2ab2b18cce5dde713c3993a198ab54351f6d54226a7bc38e1a421047403f98b5b0892cf5ee97a759fe7b8708672d26aece5af0748"} build_url:https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010731 build_url: 'https://queue.taskcluster.net/v1/task/DyOoPD4FSYahKAkhEKxc3A/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/b3d083170cdb6b6e4b1a0ec47df32e77f32d0f2b87cebac79c96bf2fc03bc117e85829208118a51dbdbb98321b73dc76ffceaa976769f8c0d3ed428649cb4213", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42cddb7e02c28c10c9a45096ddecfe0ef59da95df904493a98c289d3a4ef8582cd58a1b6f888c34ca6acca1515d0f05404d4a5c36cdab0502afcf10f821c01a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d93514a6f1525684ad372a2ab2b18cce5dde713c3993a198ab54351f6d54226a7bc38e1a421047403f98b5b0892cf5ee97a759fe7b8708672d26aece5af0748"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 22:01:29.439002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-11-10 22:01:29.439340) ========= 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.edKK20IyJo/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.X5oU4xfrrk/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005134 ========= master_lag: 4.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-11-10 22:01:33.570315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 22:01:33.570631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 22:01:33.574033) ========= ========= Total master_lag: 4.80 =========