builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0101 starttime: 1473327850.56 results: success (0) buildid: 20160907175716 builduid: 0aad801a4896498f96ec88398c84536c revision: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.561542) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.562063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.562346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.632421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.632679) ========= 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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-09-08 02:44:10-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 252M=0s 2016-09-08 02:44:11 (252 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.552720 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.253422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.253753) ========= 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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.027521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.313848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.314208) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-09-08 02:44:11,409 truncating revision to first 12 chars 2016-09-08 02:44:11,410 Setting DEBUG logging. 2016-09-08 02:44:11,410 attempt 1/10 2016-09-08 02:44:11,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/77940cbf0c2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 02:44:12,055 unpacking tar archive at: mozilla-central-77940cbf0c2a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912421 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.255423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.255800) ========= script_repo_revision: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.256243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.256577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.278443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-08 02:44:12.278761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44:12 INFO - MultiFileLogger online at 20160908 02:44:12 in /builds/slave/test 02:44:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:44:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:12 INFO - {'append_to_log': False, 02:44:12 INFO - 'base_work_dir': '/builds/slave/test', 02:44:12 INFO - 'blob_upload_branch': 'Firefox', 02:44:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:12 INFO - 'branch': 'Firefox', 02:44:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:12 INFO - 'config_files': ('talos/mac_config.py',), 02:44:12 INFO - 'default_actions': ('clobber', 02:44:12 INFO - 'read-buildbot-config', 02:44:12 INFO - 'download-and-extract', 02:44:12 INFO - 'populate-webroot', 02:44:12 INFO - 'create-virtualenv', 02:44:12 INFO - 'install', 02:44:12 INFO - 'run-tests'), 02:44:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:12 INFO - 'download_minidump_stackwalk': True, 02:44:12 INFO - 'download_symbols': 'ondemand', 02:44:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:44:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:44:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:44:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:44:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:12 INFO - 'installer_path': 'installer.exe', 02:44:12 INFO - 'log_level': 'info', 02:44:12 INFO - 'log_name': 'talos', 02:44:12 INFO - 'log_to_console': True, 02:44:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:44:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:44:12 INFO - 'opt_config_files': (), 02:44:12 INFO - 'pip_index': False, 02:44:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:12 INFO - 'cmd': ('bash', 02:44:12 INFO - '-c', 02:44:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:12 INFO - 'enabled': True, 02:44:12 INFO - 'halt_on_failure': False, 02:44:12 INFO - 'name': 'check_screen_resolution'},), 02:44:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:12 INFO - 'cmd': ('bash', 02:44:12 INFO - '-c', 02:44:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:12 INFO - 'enabled': True, 02:44:12 INFO - 'halt_on_failure': False, 02:44:12 INFO - 'name': 'check_screen_resolution'},), 02:44:12 INFO - 'run_cmd_checks_enabled': True, 02:44:12 INFO - 'sps_profile': False, 02:44:12 INFO - 'sps_profile_interval': 0, 02:44:12 INFO - 'suite': 'dromaeojs', 02:44:12 INFO - 'system_bits': '32', 02:44:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:12 INFO - 'title': 't-yosemite-r7-0101', 02:44:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:12 INFO - 'use_talos_json': True, 02:44:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:12 INFO - 'work_dir': 'build'} 02:44:12 INFO - [mozharness: 2016-09-08 09:44:12.498731Z] Running clobber step. 02:44:12 INFO - Running pre-action listener: _resource_record_pre_action 02:44:12 INFO - Running main action method: clobber 02:44:12 INFO - rmtree: /builds/slave/test/build 02:44:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:14 INFO - Running post-action listener: _resource_record_post_action 02:44:14 INFO - [mozharness: 2016-09-08 09:44:14.610872Z] Finished clobber step (success) 02:44:14 INFO - [mozharness: 2016-09-08 09:44:14.610991Z] Running read-buildbot-config step. 02:44:14 INFO - Running pre-action listener: _resource_record_pre_action 02:44:14 INFO - Running main action method: read_buildbot_config 02:44:14 INFO - Using buildbot properties: 02:44:14 INFO - { 02:44:14 INFO - "project": "", 02:44:14 INFO - "product": "firefox", 02:44:14 INFO - "script_repo_revision": "production", 02:44:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:44:14 INFO - "repository": "", 02:44:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:44:14 INFO - "buildid": "20160907175716", 02:44:14 INFO - "pgo_build": "False", 02:44:14 INFO - "basedir": "/builds/slave/test", 02:44:14 INFO - "buildnumber": 23, 02:44:14 INFO - "slavename": "t-yosemite-r7-0101", 02:44:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:44:14 INFO - "platform": "yosemite_r7", 02:44:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:44:14 INFO - "branch": "mozilla-central", 02:44:14 INFO - "repo_path": "mozilla-central", 02:44:14 INFO - "revision": "77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501", 02:44:14 INFO - "stage_platform": "macosx64", 02:44:14 INFO - "builduid": "0aad801a4896498f96ec88398c84536c", 02:44:14 INFO - "slavebuilddir": "test" 02:44:14 INFO - } 02:44:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 02:44:14 INFO - Running post-action listener: _resource_record_post_action 02:44:14 INFO - [mozharness: 2016-09-08 09:44:14.613946Z] Finished read-buildbot-config step (success) 02:44:14 INFO - [mozharness: 2016-09-08 09:44:14.614060Z] Running download-and-extract step. 02:44:14 INFO - Running pre-action listener: _resource_record_pre_action 02:44:14 INFO - Running main action method: download_and_extract 02:44:14 INFO - mkdir: /builds/slave/test/build/tests 02:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:14 INFO - trying https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 02:44:14 INFO - Downloading https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 02:44:15 INFO - Downloaded 1199 bytes. 02:44:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:44:15 INFO - Using the following test package requirements: 02:44:15 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:44:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 02:44:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 02:44:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'jsshell-mac.zip'], 02:44:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 02:44:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:44:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 02:44:15 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 02:44:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 02:44:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 02:44:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:44:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:44:16 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:44:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:44:23 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:44:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:44:30 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:31 INFO - trying https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:44:31 INFO - Downloading https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 02:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 02:44:34 INFO - Downloaded 111456518 bytes. 02:44:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:44:34 INFO - mkdir: /builds/slave/test/properties 02:44:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:34 INFO - Contents: 02:44:34 INFO - build_url:https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:44:34 INFO - Running post-action listener: _resource_record_post_action 02:44:34 INFO - Running post-action listener: set_extra_try_arguments 02:44:34 INFO - [mozharness: 2016-09-08 09:44:34.960780Z] Finished download-and-extract step (success) 02:44:34 INFO - [mozharness: 2016-09-08 09:44:34.960920Z] Running populate-webroot step. 02:44:34 INFO - Running pre-action listener: _resource_record_pre_action 02:44:34 INFO - Running main action method: populate_webroot 02:44:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:34 INFO - '--tppagecycles', 02:44:34 INFO - '7'], 02:44:34 INFO - 'tests': ['tsvgm']}}, 02:44:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['damp', 'tps']}, 02:44:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'tests': ['damp', 'tps']}, 02:44:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['dromaeo_dom']}, 02:44:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['basic_compositor_video']}, 02:44:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:44:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['a11yr', 02:44:34 INFO - 'ts_paint', 02:44:34 INFO - 'tpaint', 02:44:34 INFO - 'sessionrestore', 02:44:34 INFO - 'sessionrestore_no_auto_restore', 02:44:34 INFO - 'tabpaint']}, 02:44:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:34 INFO - 'ts_paint', 02:44:34 INFO - 'tpaint', 02:44:34 INFO - 'sessionrestore', 02:44:34 INFO - 'sessionrestore_no_auto_restore', 02:44:34 INFO - 'tabpaint']}, 02:44:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:44:34 INFO - 'ts_paint', 02:44:34 INFO - 'tpaint', 02:44:34 INFO - 'sessionrestore', 02:44:34 INFO - 'sessionrestore_no_auto_restore', 02:44:34 INFO - 'tabpaint']}, 02:44:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:44:34 INFO - 'ts_paint', 02:44:34 INFO - 'tpaint', 02:44:34 INFO - 'sessionrestore', 02:44:34 INFO - 'sessionrestore_no_auto_restore', 02:44:34 INFO - 'tabpaint']}, 02:44:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['a11yr', 02:44:34 INFO - 'ts_paint', 02:44:34 INFO - 'tpaint', 02:44:34 INFO - 'sessionrestore', 02:44:34 INFO - 'sessionrestore_no_auto_restore', 02:44:34 INFO - 'tabpaint']}, 02:44:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['a11yr', 02:44:34 INFO - 'ts_paint', 02:44:34 INFO - 'tpaint', 02:44:34 INFO - 'sessionrestore', 02:44:34 INFO - 'sessionrestore_no_auto_restore', 02:44:34 INFO - 'tabpaint']}, 02:44:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['tsvgx', 02:44:34 INFO - 'tsvgr_opacity', 02:44:34 INFO - 'tart', 02:44:34 INFO - 'tscrollx', 02:44:34 INFO - 'cart']}, 02:44:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:34 INFO - 'tsvgr_opacity', 02:44:34 INFO - 'tart', 02:44:34 INFO - 'tscrollx', 02:44:34 INFO - 'cart']}, 02:44:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'talos_options': ['--disable-e10s'], 02:44:34 INFO - 'tests': ['tp5o']}, 02:44:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'tests': ['tp5o']}, 02:44:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'talos_options': ['--disable-e10s', 02:44:34 INFO - '--xperf_path', 02:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:34 INFO - 'tests': ['tp5n']}, 02:44:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:34 INFO - 'talos_options': ['--xperf_path', 02:44:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:34 INFO - 'tests': ['tp5n']}}, 02:44:34 INFO - 'talos.zip': {'path': '', 02:44:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:34 INFO - Running post-action listener: _resource_record_post_action 02:44:34 INFO - [mozharness: 2016-09-08 09:44:34.979683Z] Finished populate-webroot step (success) 02:44:34 INFO - [mozharness: 2016-09-08 09:44:34.979792Z] Running create-virtualenv step. 02:44:34 INFO - Running pre-action listener: _resource_record_pre_action 02:44:34 INFO - Running main action method: create_virtualenv 02:44:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:34 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 02:44:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:35 INFO - Using real prefix '/tools/python27' 02:44:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:38 INFO - Installing pip.................done. 02:44:38 INFO - Return code: 0 02:44:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:38 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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44:38 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 02:44:38 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 02:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:38 INFO - 'HOME': '/Users/cltbld', 02:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:38 INFO - 'LOGNAME': 'cltbld', 02:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:38 INFO - 'MOZ_NO_REMOTE': '1', 02:44:38 INFO - 'NO_EM_RESTART': '1', 02:44:38 INFO - 'PAGER': '/bin/cat', 02:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:38 INFO - 'PWD': '/builds/slave/test', 02:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:38 INFO - 'SHELL': '/bin/bash', 02:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:38 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:38 INFO - 'USER': 'cltbld', 02:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:38 INFO - 'XPC_FLAGS': '0x0', 02:44:38 INFO - 'XPC_SERVICE_NAME': '0', 02:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 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 02:44:39 INFO - Cleaning up... 02:44:39 INFO - Return code: 0 02:44:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:39 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')]} 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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')]} 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44:39 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 02:44:39 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 02:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:39 INFO - 'HOME': '/Users/cltbld', 02:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:39 INFO - 'LOGNAME': 'cltbld', 02:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:39 INFO - 'MOZ_NO_REMOTE': '1', 02:44:39 INFO - 'NO_EM_RESTART': '1', 02:44:39 INFO - 'PAGER': '/bin/cat', 02:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:39 INFO - 'PWD': '/builds/slave/test', 02:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:39 INFO - 'SHELL': '/bin/bash', 02:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:39 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:39 INFO - 'USER': 'cltbld', 02:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:39 INFO - 'XPC_FLAGS': '0x0', 02:44:39 INFO - 'XPC_SERVICE_NAME': '0', 02:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 INFO - Downloading/unpacking psutil>=3.1.1 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:42 INFO - Installing collected packages: psutil 02:44:42 INFO - Running setup.py install for psutil 02:44:42 INFO - building 'psutil._psutil_osx' extension 02:44:42 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 02:44:43 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 02:44:43 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 02:44:43 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 02:44:43 INFO - building 'psutil._psutil_posix' extension 02:44:43 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 02:44:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:44:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:44:43 INFO - ^ 02:44:43 INFO - 1 warning generated. 02:44:43 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 02:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:43 INFO - Successfully installed psutil 02:44:43 INFO - Cleaning up... 02:44:43 INFO - Return code: 0 02:44:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:44:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:43 INFO - 'HOME': '/Users/cltbld', 02:44:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:43 INFO - 'LOGNAME': 'cltbld', 02:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:43 INFO - 'MOZ_NO_REMOTE': '1', 02:44:43 INFO - 'NO_EM_RESTART': '1', 02:44:43 INFO - 'PAGER': '/bin/cat', 02:44:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:43 INFO - 'PWD': '/builds/slave/test', 02:44:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:43 INFO - 'SHELL': '/bin/bash', 02:44:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:43 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:43 INFO - 'USER': 'cltbld', 02:44:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:43 INFO - 'XPC_FLAGS': '0x0', 02:44:43 INFO - 'XPC_SERVICE_NAME': '0', 02:44:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:44:46 INFO - Installing collected packages: mozsystemmonitor 02:44:46 INFO - Running setup.py install for mozsystemmonitor 02:44:46 INFO - Successfully installed mozsystemmonitor 02:44:46 INFO - Cleaning up... 02:44:46 INFO - Return code: 0 02:44:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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', '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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:44: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 jsonschema==2.5.1 02:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:46 INFO - 'HOME': '/Users/cltbld', 02:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:46 INFO - 'LOGNAME': 'cltbld', 02:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:46 INFO - 'MOZ_NO_REMOTE': '1', 02:44:46 INFO - 'NO_EM_RESTART': '1', 02:44:46 INFO - 'PAGER': '/bin/cat', 02:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:46 INFO - 'PWD': '/builds/slave/test', 02:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:46 INFO - 'SHELL': '/bin/bash', 02:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:46 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:46 INFO - 'USER': 'cltbld', 02:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:46 INFO - 'XPC_FLAGS': '0x0', 02:44:46 INFO - 'XPC_SERVICE_NAME': '0', 02:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:44:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:44:49 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 02:44:49 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 02:44:49 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 02:44:49 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 02:44:49 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 02:44:49 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 02:44:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:44:50 INFO - warning: no files found matching '*.txt' 02:44:50 INFO - no previously-included directories found matching 'build' 02:44:50 INFO - no previously-included directories found matching 'dist' 02:44:50 INFO - no previously-included directories found matching '.git*' 02:44:50 INFO - Installing collected packages: jsonschema, functools32 02:44:50 INFO - Running setup.py install for functools32 02:44:50 INFO - warning: no files found matching '*.txt' 02:44:50 INFO - no previously-included directories found matching 'build' 02:44:50 INFO - no previously-included directories found matching 'dist' 02:44:50 INFO - no previously-included directories found matching '.git*' 02:44:50 INFO - Successfully installed jsonschema functools32 02:44:50 INFO - Cleaning up... 02:44:50 INFO - Return code: 0 02:44:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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', '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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:44: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 functools32==3.2.3-2 02:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:50 INFO - 'HOME': '/Users/cltbld', 02:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:50 INFO - 'LOGNAME': 'cltbld', 02:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:50 INFO - 'MOZ_NO_REMOTE': '1', 02:44:50 INFO - 'NO_EM_RESTART': '1', 02:44:50 INFO - 'PAGER': '/bin/cat', 02:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:50 INFO - 'PWD': '/builds/slave/test', 02:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:50 INFO - 'SHELL': '/bin/bash', 02:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:50 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:50 INFO - 'USER': 'cltbld', 02:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:50 INFO - 'XPC_FLAGS': '0x0', 02:44:50 INFO - 'XPC_SERVICE_NAME': '0', 02:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:44:50 INFO - Cleaning up... 02:44:50 INFO - Return code: 0 02:44:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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', '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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:44: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 blobuploader==1.2.4 02:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:50 INFO - 'HOME': '/Users/cltbld', 02:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:50 INFO - 'LOGNAME': 'cltbld', 02:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:50 INFO - 'MOZ_NO_REMOTE': '1', 02:44:50 INFO - 'NO_EM_RESTART': '1', 02:44:50 INFO - 'PAGER': '/bin/cat', 02:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:50 INFO - 'PWD': '/builds/slave/test', 02:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:50 INFO - 'SHELL': '/bin/bash', 02:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:50 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:50 INFO - 'USER': 'cltbld', 02:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:50 INFO - 'XPC_FLAGS': '0x0', 02:44:50 INFO - 'XPC_SERVICE_NAME': '0', 02:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:44:50 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 02:44:50 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 02:44:50 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 02:44:50 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 02:44:50 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 02:44:50 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 02:44:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44:54 INFO - Downloading docopt-0.6.1.tar.gz 02:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:54 INFO - Running setup.py install for blobuploader 02:44:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:54 INFO - Running setup.py install for requests 02:44:55 INFO - Running setup.py install for docopt 02:44:55 INFO - Successfully installed blobuploader requests docopt 02:44:55 INFO - Cleaning up... 02:44:55 INFO - Return code: 0 02:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:55 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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:44:55 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 02:44:55 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 02:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:55 INFO - 'HOME': '/Users/cltbld', 02:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:55 INFO - 'LOGNAME': 'cltbld', 02:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:55 INFO - 'MOZ_NO_REMOTE': '1', 02:44:55 INFO - 'NO_EM_RESTART': '1', 02:44:55 INFO - 'PAGER': '/bin/cat', 02:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:55 INFO - 'PWD': '/builds/slave/test', 02:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:55 INFO - 'SHELL': '/bin/bash', 02:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:44:55 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:55 INFO - 'USER': 'cltbld', 02:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:55 INFO - 'XPC_FLAGS': '0x0', 02:44:55 INFO - 'XPC_SERVICE_NAME': '0', 02:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-CEXnj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-yBz0XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:55 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-wKC4iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-UPN0QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VoHWF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Ldpar8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-y7FDmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-KFv60Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-evqAUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-XgMG63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-1oIqSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:56 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-IBGXsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:57 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-L5f_zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:57 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bi6VlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:57 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-V5YAil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:57 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-N4Y2yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:57 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VAoDU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:57 INFO - Running setup.py install for manifestparser 02:44:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:57 INFO - Running setup.py install for mozcrash 02:44:57 INFO - Running setup.py install for mozdebug 02:44:57 INFO - Running setup.py install for mozdevice 02:44:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozfile 02:44:58 INFO - Running setup.py install for mozhttpd 02:44:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozinfo 02:44:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozInstall 02:44:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozleak 02:44:58 INFO - Running setup.py install for mozlog 02:44:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for moznetwork 02:44:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozprocess 02:44:59 INFO - Running setup.py install for mozprofile 02:44:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozrunner 02:44:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozscreenshot 02:44:59 INFO - Running setup.py install for moztest 02:44:59 INFO - Running setup.py install for mozversion 02:45:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:00 INFO - Cleaning up... 02:45:00 INFO - Return code: 0 02:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:00 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')]} 02:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:00 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')]} 02:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:00 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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:45:00 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 02:45:00 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 02:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:00 INFO - 'HOME': '/Users/cltbld', 02:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:00 INFO - 'LOGNAME': 'cltbld', 02:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:00 INFO - 'MOZ_NO_REMOTE': '1', 02:45:00 INFO - 'NO_EM_RESTART': '1', 02:45:00 INFO - 'PAGER': '/bin/cat', 02:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:00 INFO - 'PWD': '/builds/slave/test', 02:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:00 INFO - 'SHELL': '/bin/bash', 02:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:45:00 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:00 INFO - 'USER': 'cltbld', 02:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:00 INFO - 'XPC_FLAGS': '0x0', 02:45:00 INFO - 'XPC_SERVICE_NAME': '0', 02:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-6AfqT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:00 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)) 02:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-z266SG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:00 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)) 02:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-1iaknu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:00 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)) 02:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-AkZeXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:00 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)) 02:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-TdultF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:00 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)) 02:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:00 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-cpM1f5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-GqtF8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ibVz74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-PZYTKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-hoYKvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-zVBmzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-46ZgHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-tjbamt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Cz5Ur9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-nPNVfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:01 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-jF_6Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:02 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ylbkOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:02 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)) 02:45:02 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)) 02:45:02 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)) 02:45:02 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)) 02:45:02 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)) 02:45:02 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)) 02:45:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - Downloading blessings-1.6.tar.gz 02:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:04 INFO - Installing collected packages: blessings 02:45:04 INFO - Running setup.py install for blessings 02:45:04 INFO - Successfully installed blessings 02:45:04 INFO - Cleaning up... 02:45:05 INFO - Return code: 0 02:45:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:05 INFO - Reading from file tmpfile_stdout 02:45:05 INFO - Current package versions: 02:45:05 INFO - blessings == 1.6 02:45:05 INFO - blobuploader == 1.2.4 02:45:05 INFO - docopt == 0.6.1 02:45:05 INFO - functools32 == 3.2.3-2 02:45:05 INFO - jsonschema == 2.5.1 02:45:05 INFO - manifestparser == 1.1 02:45:05 INFO - mozInstall == 1.12 02:45:05 INFO - mozcrash == 0.17 02:45:05 INFO - mozdebug == 0.1 02:45:05 INFO - mozdevice == 0.48 02:45:05 INFO - mozfile == 1.2 02:45:05 INFO - mozhttpd == 0.7 02:45:05 INFO - mozinfo == 0.9 02:45:05 INFO - mozleak == 0.1 02:45:05 INFO - mozlog == 3.3 02:45:05 INFO - moznetwork == 0.27 02:45:05 INFO - mozprocess == 0.23 02:45:05 INFO - mozprofile == 0.28 02:45:05 INFO - mozrunner == 6.12 02:45:05 INFO - mozscreenshot == 0.1 02:45:05 INFO - mozsystemmonitor == 0.3 02:45:05 INFO - moztest == 0.7 02:45:05 INFO - mozversion == 1.4 02:45:05 INFO - psutil == 3.1.1 02:45:05 INFO - requests == 1.2.3 02:45:05 INFO - wsgiref == 0.1.2 02:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:05 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')]} 02:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:05 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')]} 02:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:05 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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:45:05 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 02:45:05 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 02:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:05 INFO - 'HOME': '/Users/cltbld', 02:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:05 INFO - 'LOGNAME': 'cltbld', 02:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:05 INFO - 'MOZ_NO_REMOTE': '1', 02:45:05 INFO - 'NO_EM_RESTART': '1', 02:45:05 INFO - 'PAGER': '/bin/cat', 02:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:05 INFO - 'PWD': '/builds/slave/test', 02:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:05 INFO - 'SHELL': '/bin/bash', 02:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:45:05 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:05 INFO - 'USER': 'cltbld', 02:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:05 INFO - 'XPC_FLAGS': '0x0', 02:45:05 INFO - 'XPC_SERVICE_NAME': '0', 02:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 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)) 02:45:05 INFO - Cleaning up... 02:45:05 INFO - Return code: 0 02:45:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45:05 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')]} 02:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:05 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')]} 02:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:05 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 0x10749da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107532618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f851ada39f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, '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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 02:45:05 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 02:45:05 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 02:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:05 INFO - 'HOME': '/Users/cltbld', 02:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:05 INFO - 'LOGNAME': 'cltbld', 02:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:05 INFO - 'MOZ_NO_REMOTE': '1', 02:45:05 INFO - 'NO_EM_RESTART': '1', 02:45:05 INFO - 'PAGER': '/bin/cat', 02:45:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:05 INFO - 'PWD': '/builds/slave/test', 02:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:05 INFO - 'SHELL': '/bin/bash', 02:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:45:05 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:05 INFO - 'USER': 'cltbld', 02:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:05 INFO - 'XPC_FLAGS': '0x0', 02:45:05 INFO - 'XPC_SERVICE_NAME': '0', 02:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:45:05 INFO - Cleaning up... 02:45:05 INFO - Return code: 0 02:45:05 INFO - Running post-action listener: _resource_record_post_action 02:45:05 INFO - Running post-action listener: _start_resource_monitoring 02:45:05 INFO - Starting resource monitoring. 02:45:05 INFO - [mozharness: 2016-09-08 09:45:05.853426Z] Finished create-virtualenv step (success) 02:45:05 INFO - [mozharness: 2016-09-08 09:45:05.854391Z] Running install step. 02:45:05 INFO - Running pre-action listener: _resource_record_pre_action 02:45:05 INFO - Running main action method: install 02:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:06 INFO - Reading from file tmpfile_stdout 02:45:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:06 INFO - Reading from file tmpfile_stdout 02:45:06 INFO - Output received: 02:45:06 INFO - Usage: mozinstall [options] installer 02:45:06 INFO - Options: 02:45:06 INFO - -h, --help show this help message and exit 02:45:06 INFO - -d DEST, --destination=DEST 02:45:06 INFO - Directory to install application into. [default: 02:45:06 INFO - "/builds/slave/test"] 02:45:06 INFO - --app=APP Application being installed. [default: firefox] 02:45:06 INFO - mkdir: /builds/slave/test/build/application 02:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:45:40 INFO - Reading from file tmpfile_stdout 02:45:40 INFO - Output received: 02:45:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:45:40 INFO - Running post-action listener: _resource_record_post_action 02:45:40 INFO - [mozharness: 2016-09-08 09:45:40.416538Z] Finished install step (success) 02:45:40 INFO - [mozharness: 2016-09-08 09:45:40.416670Z] Running run-tests step. 02:45:40 INFO - Running pre-action listener: _resource_record_pre_action 02:45:40 INFO - Running main action method: run_tests 02:45:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:45:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:45:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:45:40 INFO - 2016-09-08 02:45:40.430 screenresolution[1641:8061] starting screenresolution argv=screenresolution get 02:45:40 INFO - 2016-09-08 02:45:40.433 screenresolution[1641:8061] Display 0: 1600x1200x32@60 02:45:40 INFO - 2016-09-08 02:45:40.439 screenresolution[1642:8064] starting screenresolution argv=screenresolution list 02:45:40 INFO - Available Modes on Display 0 02:45:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:45:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:45:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:45:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:45:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:45:40 INFO - Intel Iris: 02:45:40 INFO - Chipset Model: Intel Iris 02:45:40 INFO - Type: GPU 02:45:40 INFO - Bus: Built-In 02:45:40 INFO - VRAM (Dynamic, Max): 1536 MB 02:45:40 INFO - Vendor: Intel (0x8086) 02:45:40 INFO - Device ID: 0x0a2e 02:45:40 INFO - Revision ID: 0x0009 02:45:40 INFO - Displays: 02:45:40 INFO - Display: 02:45:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:45:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:45:40 INFO - Display Serial Number: 1600x1200 60 02:45:40 INFO - Main Display: Yes 02:45:40 INFO - Mirror: Off 02:45:40 INFO - Online: Yes 02:45:40 INFO - Rotation: Supported 02:45:40 INFO - Return code: 0 02:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:40 INFO - Python 2.7.3 02:45:40 INFO - Return code: 0 02:45:40 INFO - grabbing minidump binary from tooltool 02:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:40 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 0x107401d30>, '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 0x107166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073f9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:40 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 02:45:40 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 02:45:40 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 02:45:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:40 INFO - Return code: 0 02:45:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:45:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:45:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 02:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --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 02:45:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NMlWxdKZC9/Render', 02:45:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:40 INFO - 'HOME': '/Users/cltbld', 02:45:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:40 INFO - 'LOGNAME': 'cltbld', 02:45:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:40 INFO - 'MOZ_NO_REMOTE': '1', 02:45:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:40 INFO - 'NO_EM_RESTART': '1', 02:45:40 INFO - 'PAGER': '/bin/cat', 02:45:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:40 INFO - 'PWD': '/builds/slave/test', 02:45:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:40 INFO - 'SHELL': '/bin/bash', 02:45:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JrAqd0BqUQ/Listeners', 02:45:40 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:45:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:40 INFO - 'USER': 'cltbld', 02:45:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:40 INFO - 'XPC_FLAGS': '0x0', 02:45:40 INFO - 'XPC_SERVICE_NAME': '0', 02:45:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 02:45:41 INFO - mozversion application_buildid: 20160907175716 02:45:41 INFO - mozversion application_changeset: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 02:45:41 INFO - mozversion application_display_name: Nightly 02:45:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:41 INFO - mozversion application_name: Firefox 02:45:41 INFO - mozversion application_remotingname: firefox 02:45:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:45:41 INFO - mozversion application_vendor: Mozilla 02:45:41 INFO - mozversion application_version: 51.0a1 02:45:41 INFO - mozversion platform_buildid: 20160907175716 02:45:41 INFO - mozversion platform_changeset: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 02:45:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:45:41 INFO - mozversion platform_version: 51.0a1 02:45:41 INFO - using testdate: 1473327941 02:45:41 INFO - actual date: 1473327941 02:45:41 INFO - starting webserver on 'localhost:49265' 02:45:41 INFO - SUITE-START | Running 2 tests 02:45:41 INFO - TEST-START | dromaeo_css 02:45:41 INFO - operating with platform_type : mac_ 02:45:41 INFO - Initialising browser for dromaeo_css test... 02:45:41 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpla7Pkk/profile http://localhost:49265/getInfo.html) 02:45:43 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 02:45:43 INFO - PROCESS | 1652 | colorDepth:24 02:45:43 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 02:45:43 INFO - PROCESS | 1652 | __metrics 02:45:43 INFO - PROCESS | 1652 | 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" 02:45:43 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:45:44 INFO - TEST-INFO | 1652: exit 0 02:45:44 INFO - Browser initialized. 02:45:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:44 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpla7Pkk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:55 INFO - PROCESS | 1655 | RSS: Main: 232292352 02:45:55 INFO - PROCESS | 1655 | 02:46:47 INFO - PROCESS | 1655 | 1473328007583 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] 02:48:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 02:49:00 INFO - PROCESS | 1655 | RSS: Main: 372330496 02:49:00 INFO - PROCESS | 1655 | 02:52:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 02:52:03 INFO - PROCESS | 1655 | RSS: Main: 373166080 02:52:03 INFO - PROCESS | 1655 | 02:55:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 02:55:06 INFO - PROCESS | 1655 | RSS: Main: 336580608 02:55:06 INFO - PROCESS | 1655 | 02:58:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 02:58:09 INFO - PROCESS | 1655 | RSS: Main: 337461248 02:58:09 INFO - PROCESS | 1655 | 03:01:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 03:01:13 INFO - PROCESS | 1655 | RSS: Main: 335753216 03:01:13 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 03:04:17 INFO - PROCESS | 1655 | RSS: Main: 413704192 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | __start_tp_report 03:04:17 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 03:04:17 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 03:04:17 INFO - PROCESS | 1655 | |i|pagename|runs| 03:04:17 INFO - PROCESS | 1655 | |0;dojo.html;3300.6204286507045;3315.220923083075;3342.331533693262;3380.239446124621;3391.9152021199466;5578.581606379517;5715.199872017921;5724.885502289952;5734.59857809953;5746.597738158325;5652.321721393429;5745.195672605839;5759.10733836255;5764.884702305952;5831.125331200312;5169.534741873231;5215.035218484573;5222.373315202171;5246.029484545352;5251.212318152269;5284.735763211843;5288.629795914288;5291.047611429941;5291.417944026154;5309.123994540896;4643.698159619614;5287.947120528803;5306.70813105279;5309.575233981292;5316.441773613773;5145.871353216162;5174.404943431478;5221.347331583552;5235.424103348629;5302.992431438053;5129.384473863161;5163.922541161885;5217.3217481727515;5217.373915130209;5232.607554433433;5732.8853422931725;5737.856553586152;5760.913586296209;5770.88458230833;5810.535157187415;6295.0872123542285;6295.7166927487915;6300.1494798202575;6304.621722696653;6310.053491976194;6109.16175461965;6256.1866957295715;6309.116723658692;6358.904616430757;6371.426571608577;5822.708864556797;5848.590598658138;5852.444017818258;5857.179994800731;5904.793332233351;6303;6352.951762959153;6359;6369.872602547923;6378.77674281398;6056.273247210363;6125.20492926512;6131.877362452726;6180.721867515973;6223.626582405071;6232.034034724625;6260.186175797117;6281.309056003836;6292.087647291117;6315.052742088632;6259.405356491126;6279.811605651837;6281.963476026496;6298.496120310364;6310.905336419957;6096.194094249989;6116.579253789288;6314.62112273265;6329.651869147241;6337.904931426032;4991.850244492671;4997.90004199914;5003.424606170337;5004.699718016931;5011.674241174312;4447.710898791568;4450.421445212167;4457.710248833815;4468.3074123510905;4492.460904691393;5600.719964001783;5737.8565535861935;5748.080307150836;5749.942500574941;5783.074708046776;6228.937710622836;6245.594036387711;6270.2475702915945;6304.180456540712;6384.7126879290545;5733.122546990553;5738.282714660668;5752.395998420189;5758;5787.884242315215;5345.86635334112;5429.511343979061;5443.700596467233;5455.754491047913;5461.0716178249795;5787.2187254720075;6271.905921411091;6317.431431171033;6342.207224096988;6368.14030105939;5300.469953004668;6079.452849243589;6329.8904288584745;6340.651264180515;6369.394907483782;6317.6958172255445;6347.079673447232;6347.650879201688;6359.618422894641;6376.649284289409;6104.572679912541;6141.915626108766;6148.50811935053;6150.323464419;6253.593516421418;6324.335944725737;6328.335524769833;6328.936710632835;6337.081123237197;6338.714757836001;4568;6110.633361998294;6184.505239580732;6190.350013248544;6193.876122477615;5156.61325400604;5998.160257563857;6067.666278354556;6093.987814007425;6138.2044803098925;5963.671998040149;5964;5969.194158788508;5975.760969561169;6010.398960103955;5825.155352473952;6012;6107.328193898757;6128.295246046761;6163.96918015425;5914.349421563538;5999.880002400015;6045.365236650265;6045.697715114315;6118.571699980958 03:04:17 INFO - PROCESS | 1655 | |1;ext.html;487.51005239734064;521.6192179708812;540.3785646506519;546.985342190237;555.7526900529266;29992.400151996946;32292.838535807317;32333;32462.837685811595;32465.837670811612;32716.182095447624;40545.39181912266;41795.79102104485;41799;44713.10573788531;9715.805683886318;9872.703818885446;9890.653827116052;9890.653827116052;9895.356801807895;9686.273529485317;9785.266105042114;9795.412275263507;9803.117719405253;9806.705798826046;9793.853092203623;9804.166645835112;9825.754356141118;9825.754356141118;9843;8880.8667869982;9347.298952578583;9755.170810481117;9779.364341317792;9796.363236389612;9683.757906052335;9750.414975101447;9763.560639771227;9785.168260697848;9794.02059794022;31837;38496;38610.227795443934;38619.806900965596;38671.61328386708;2914.0383673387732;3298.290867463507;3320.6257525868878;3343.114074770188;3416.6754158355166;29417.70582294171;30453.934112305964;30488.69511304881;30506.08481745551;30526;3276.1318250663594;3279.8852040178717;3360.6807353301397;3360.949585756191;3371.342588195303;366347;370196;370902;372488;376554;56540.71729641408;56727.71636141793;56883;56901.861962760515;56951;52581.6338264779;55840.441595584336;58932.285417166524;58947.41052589505;58975.70512147497;15836;16060.839391606169;16074.035557866566;16084.43704470338;16098.195090245441;12538.435770390355;12592.181508201938;12600.684982875318;12614.558490452973;12614.990800735919;11074.723131921766;14832.406703731946;14949.40202391914;14976.026558273677;14982.876284278722;6350.714217860207;6640.966795165993;6759.966200168968;6786.966065169741;6895.793126206222;712.9059880120303;740.6704016712619;887.933404994628;927.79124696944;1097.4183682648209;28566.714332856405;29179;29482.705172947997;29665.25836854096;29727;963.8602402651576;1016.9338992965434;1036.6060896859144;1076.7200527862813;1126.4987080749152;14871.33079011447;14932.776008359884;15028.549143525712;15279;15316.923415382851;690383;696064;696380;696581;698089;54995;55154;55154.44845551573;55186;55260.72369638126;1241.3420886929941;1337.297918592766;1377.2975782351073;1387.3202130955558;1388.4099257815387;26851.462970740085;27355.76899039508;30495.54256686107;30685.07944761661;31005.379892402478;46459.30311045405;46968;46983.76508117437;47109;47117.822054448916;556323;558775;559268;559407;560795;23287.650685239398;23776.762232378147;23780.286591402284;24400.51198975975;26372.208833735018;46161.30758038565;47557.524424756695;47701;47899.28151077667;48531;37759.62240377671;37825.24349512939;38201;38734.612653873104;39392;37150;37712.43431348587;38250.80874595609;38473.038174044756;39015.80492097521;32804.50793238151;37860.810695947446;37956.291966861005;37973.05067373227;38600;28555.714442855304;29273.7072629271;33598.83200583982;34159.82920085483;34924.825375872955;22413.43966400853;23478.295651130495;24669.01323947094;24729;25042.37394065163 03:04:17 INFO - PROCESS | 1655 | |2;jquery.html;352.56810407251135;371.4947671167213;373.61144409813795;381.7575839342019;402.9939550906737;13551.457941682333;15609.92195039026;20017.1993120275;20686.896565517152;21308.786912130894;19863.006849657533;19976.600467990633;20499.590008199826;20686.48283792906;20693.379198624065;5671.120976248688;5743.942560574404;5966.9403305967035;6007.849803754897;6008;4145.709800313979;4367;5828.6211396259105;6006.759729610811;6318.589291696025;6533.379328963741;6616.206055273374;6618.404343609074;6632.30360812115;6639.800805975829;6306;6516.446102081305;6562.540622156451;6574.046763219354;6620.668966551653;5450.4822041906355;5604.3835178130375;5677.971610141964;5691.800786972436;5706.229658996024;25611;25683.35791605206;25842.87078564595;25975.350616234555;26229;2125.362391282609;2182.6289530779804;2257.864528128301;2273.8067264282554;2372.6203807390907;14987;15327;15521;15605.68788624221;15946.362145514166;1822.6992546229856;1831.4414103698366;1870.3734249026593;1873.690841011245;1932.884026958387;115842.84157158405;122636.94616899846;128154.3592282042;128688.3565582166;128845.35577322147;10852.255971689754;10954.452277386099;11305.569302599815;11347.48936297852;11508;11742.823857642143;14118.71762564743;14120.929395352958;14154.221517816413;14167.71664566703;7351.558906465629;7945.960270198612;8410.570203065494;8457.323414126855;8586.78533036679;8289.502629842229;8297.709580164665;8334.20825021622;8474.406791524534;8481.109483504266;4361.193179261847;4422.624076953431;4485.416895803524;4509.6392288616835;4525.841595544141;1770.4954088084835;1806.9006204658608;1874.8968806715488;1885.660581095416;1912.5123093611319;917.2570218123342;932.6083045121065;956.9425834449955;960.3661583354952;1011.9696409107738;17175.828241717674;19341.12964916582;20709.896450517652;20934.895325523274;20946;867.1891781184613;902.120432578231;931.9767005824773;948.7817801905601;985.0346660272972;8919.554022298858;9311.674091406769;10044.748881278027;10118.898811011943;10993.505292261867;415989;444622;445428;586894.3931682056;597921;138806;143365;153896;154032.22983885233;156073.2196339011;972.6401231544373;1001.834697274956;1016.1413605503337;1016.6492560066913;1021.1218352217087;18243.361482348053;19016.619667606847;19034.428967131007;19035.428937131906;19066.428007159808;39463.60536394599;47637;51296.74351628218;56974.71512642576;57298.713506433865;78389.60805196165;84715.57642211749;85185;85631;85636.1436385653;7607;7694.307512323918;7848.568328741974;7864;8121.675132994614;12182.269063856196;12539.310337931502;12667.303298318313;12726.23642581411;12741;10250.128739056965;10849.837252441062;10953.178511611502;10964.28732132409;11040.889591103985;7943.364530837634;10750.139988801033;11117.552399324435;11143.387113708824;11154.43448006979;8448.788780280542;9039.276857851488;10950.34297942126;10967.451627418437;11112.333260004425;7702.306792388487;7942.880856787268;7955.164707705608;8169.87583228353;8180.386471014579;10020.69937901864;10815.513301901276;10851.837222441827;11004.889951100387;11183.384913829817 03:04:17 INFO - PROCESS | 1655 | |3;mootools.html;1337.4048548395965;1483.584596313032;1677.379369633236;1871.4759867237178;1928.7878333383326;8415.579221038946;8916.955415222916;8920.063393343695;8934.776630584238;8955.820883582324;7806.882896756553;8029.237222463871;8477.830443391143;8641.611127499262;8652.567371631409;2346.7770561796647;2382.7855493005627;2386.0217310902535;2388.486475407787;2390.270967354956;2045.7340545729035;2308.665243539686;2386.1409892438796;2387.510560335136;2390.8924098415528;2355.729091154522;2367.490989437271;2372.7152741671025;2381.261808839257;2384.8092152627746;2342.7305859825997;2358.292512246328;2361.0791791201445;2371.8221133414977;2376.0020791267707;2333.3116730564525;2348.8825558722165;2355.5053438777877;2355.5406695694346;2356.375560476475;8715.215630593213;8763.912360876373;8803.867941980876;8820.8676869847;8867.379283450162;5191.377034755816;5331.760070796823;5333.333333333333;5334.146536554172;5334.199870019489;3138.4037032963665;3652.470391793175;3659.8170091495317;3725.5156829612247;3740.251949610089;1084.4902895639116;1088.4775307852196;1089.2756317049152;1093.8796732359433;1101.427257825934;11485;11570.421478926104;11580.594679186188;11586.47860846264;11605.4197290136;4505.234110201273;4613.746243956614;4781.617470602343;4792.904141917142;4802.159622066124;8263.462874913112;9812.264080194014;9821.116099550933;9835.606575737034;9888.456134912649;5337.599680024014;5337.866553336197;5340.599455040888;5346.385165705916;5350.304460420199;4419.9337009944875;4569.405977222939;4740.383750112533;4848.248521479177;4898.069366820293;3855.6722678572637;3868.903277418087;3958.129211573449;3990.8004599770475;3992.404936791109;1303.4395210059765;1303.7262174943178;1308.9345532723326;1321.3261236769124;1321.841379034522;771.5602106799183;844.6072576252072;869.7173418638968;908.1055160666738;920.8756817829641;5650.943490565124;5783.306003279633;5896.292444906553;5957.76168953237;6168.383161683796;422.9175310814423;427.58737818005153;435.6906596316587;438.68195558220674;438.92318844202134;3924.50943632046;3995.06116062725;4002.8999275017777;4028.2144981728866;4062.614051665087;10262.692119236435;10637.255392122477;10645.414502202299;10809.459527023617;10818.134549236041;10762.300450470695;10770.246082774287;10786.78426431467;10793.67618971432;10806.18953578469;7999.880001799977;8171.101178870438;8202.17978202175;8206.22040906113;8208.302294305051;5687.43125687428;5941.31674857397;6076.513878889767;6155.876882462415;6160.568760186744;9462.195713364441;10018.298719089886;10046.196304295785;10076.294659373774;10084.193264538673;10317.226208034277;10326.535305911102;10332.173426126043;10342.896571034193;10343.224258180517;6980.965095174694;7189;7401.037865077506;7515.436342274242;7647.847043058996;7210.2789721027475;8197.549134797644;8515.020772610982;8527.147285271423;8560.571971401281;7098.787036388917;7134.1795693495915;7323.6338183089565;7404.444666649915;7506.774796756106;7345.485815992829;7377.4835761498325;7386.0767404074495;7404.111506619241;7489.251074892467;6969.965150174216;6979.790606281819;7058.047163633049;7059.61172135517;7060.505764596634;4940.11078005948;4995.550400463976;5014.548690617862;5034.597232221487;5124.436312005751;4891.63312751538;4991.925121123259;5100.69395836251;5212.739363031757;5213.244079608511 03:04:17 INFO - PROCESS | 1655 | |4;prototype.html;301.42578388170534;304.3122543052702;309.8264971615896;315.34251086484676;317.66962359146487;5351.464853514652;5360.249565060894;5370.516653501184;5387.568994480442;5412.9458705412935;4437.378766972626;5332.080920523412;5337.11937530307;5368.382635996862;5382.327209098863;3904.906626144684;4025.476688030552;4048.615381538764;4064.5732198119217;4074.3888416737577;3588.6052534221344;3982.5021872265966;4066.573009833969;4077.8980525486804;4099.754014759109;4046.312126938413;4050.513938327405;4073.083556199846;4074.409210664452;4099.221147981874;3375.476801095834;3717.814109294538;3784.678302344304;4050.7164498485117;4079.2657321682086;3162.414953233659;3213.4376484115187;3361.2605226850055;3390.728741700683;3522.2779330237495;5057.963117560891;5115.590752739772;5133.973205358906;5144.019552472288;5163.845084647466;3508.2106526031694;4353.869383918487;4646.746328030902;4651.3255577941345;4669.999999999966;4939.518144556619;5254;5509.311336082989;5575.275214222166;5600.919494278171;3594.1733401317583;3901.882943511699;3904.3362628353248;3907.808118523849;3914.451976723261;4941.838667913037;5212.400573934008;5269.6311258211945;5510.586705997066;5693.28833895763;3374.865005399806;3558.6797188252663;3850.537935447764;3870.651641352292;3981.980090099531;3575.80333081683;3893.980530097331;4058.5332686740812;4062.6343629073526;4068.270984831435;4104.42914664244;4154.709170358106;4449.310356894686;4699.694519856198;4702.224133018082;4910.779014944336;5011.945102507954;5128.435872054071;5640.8871822563315;5641.26663533738;1128.0298942909092;1164.6447833410891;1175.0129890891521;1317.8403005355226;1346.4344975110282;777.4868586732729;841.6113412868693;855.9871601925976;856.4005196362571;856.6616186606255;3849.0946981244465;4031.3952907064177;4111.691623128278;4325.118573420509;4386.780660967002;4000.6399424051974;4158.690012646007;4813.735244561512;4862.107046307441;4871.391076115486;4148.170365926827;4382.101669157815;4384.610387338908;4385.473743150842;4386.298192289219;2113.9577208455744;2288.2791920544973;2389.6140238661533;2478.3542770553045;2552;4201.495820501559;4313.986213239886;4470.284754439274;4751.95248047522;4945.711102117124;4927.926081108714;5003.374578177728;5035.917277785294;5035.974820125949;5043.469571300105;5041.773120209599;5467.753951072212;5539.612227144223;5915.792947246826;6024.487918526975;4688.484266730725;5808.21589085485;5878.853623543368;5881.7647294107755;5913.924759125317;4468.391379103455;5148.021875843578;5327.866803329948;5356.812511562077;5771.624844385102;5793.217915581343;5835.79574714883;5893.44012318829;5970.5223582114195;6072.423119803611;3459.4605400596492;3525.2773181498246;4005.599440055971;4046.615571520701;4088.7955602219176;5059.747012649426;5611.214429979887;5809.622374545641;5819.486933397263;5824.912626310524;5264.605154613343;5510.197963405238;5654.802081927113;5689.886202276014;5697.829065128053;4492.415985921809;5646.85882852932;5654.688992105309;5674;5765.221695071112;4804.765783910499;4809.9038019240115;5082.872928176826;5269.262303277621;5660.499967508696;5107.948920510896;5240.978009288152;5620.325560932714;5627.945799783131;5650.3219613646625;5186.9221961669855;5549.334079910436;5595.944040559542;5623.325200975909;5636.830895073154 03:04:17 INFO - PROCESS | 1655 | |5;yui.html;700.8458139209374;740.8259059121106;775.6393277126135;801.9278264956152;824.521777369126;15529.378824847006;16657.083860387705;16683.582910427245;16692.41576544821;16692.83307166931;14950.626234344147;15057.17185554794;15090.39638414462;15096.245187740597;15131.54605361841;692.8267933016746;711.3384552366298;845.6067928413302;859.5916939453741;885.1148851148852;839.9034111077212;847.9236868681818;849.3205435651485;849.8130411309502;851.1998721202082;900.2168113741054;900.860366643168;901.1169054326764;903.0472851142042;906.0305473143738;895.3329769321832;896.2426749396749;896.4755617963499;897.2328658996595;897.5377680494518;544.4990608640061;674.5177198303237;684.9863002739917;690.4096997067535;693.968771405288;14788.334524946404;14808.185549794756;14839.25803709821;14850.405983760636;14858.702825943528;13497.595072147753;14006.22965736884;14155.43378264868;14172.92913535436;14229.359678814479;12594.37028148589;12959.67600809978;13015.544455944091;13137.08806655623;13497.12268702541;4553.089382123589;4605.309203619484;4613.146567884952;4798.184308667535;4802.447718512346;109625.9999999992;125793;128350;128696.35651821774;129902;10894.61868834587;10951.780964380827;10976.755341474747;10976.780464390667;11490.310581365145;22190.223342183268;22250.44373890633;22278.66328020324;22279.220227291968;22316.995735191955;7392.889106663404;7617.200193979663;7767.417443691746;7796.805079873048;8058.959705201553;4405.140997505519;4440.7335559866515;4482.058767658763;4532.614727748112;4605.194091034055;3396.1679388549965;3545.308664810337;3550.609432962372;3551.3074950384944;3552.7335449841366;533.6157966264284;646.7057488842565;649.3863299182227;652.2140820311513;652.5921299188008;535.9383670877899;562.1343131577325;565.3922033813667;588.9558283128782;639.7441023590508;8528.616212270463;8702.73810297516;9129.406588571721;9216.157706236263;9280.489573073546;601.9969900150471;609.3248463086873;622.3682961793783;639.48840927258;640.9487241020707;4250.692562032748;4465.665075119379;4469.195544801902;4486.3494793254795;4558.589726924526;96852.54721179188;97417;117182;153586.23206883893;157802.2109889443;146757;147361;150000;150605;157185;120445.39777301233;121250.39374803069;121343;122915;124829.37585312016;8548.829023419621;8586.184312490303;8724.43291186071;8768;8869.11308869108;45859.54140458553;52677.20984185164;54293.72853135709;59458.108128378975;62140.689296553224;78502.6074869622;79111;92935.53532232296;94413.5279323599;95064.52467737618;10693.411862347646;13084.738305234032;13139.737205256033;13356.265405402795;13568.796468053184;14527.85472145265;14904.552863414116;15276.312565934782;15305.363516110692;15812.97215680977;11395.601153959571;12693.048021398248;14505;14582;14739.705205896036;13497.527586534425;13517;13853.861461385257;14210.78683819723;14406.991510594158;11447.427628618703;13822.308884555932;13843.169409835442;13890.722185556031;14198.787018194529;11352.432378381212;11380.658580242605;11403.657890263305;11599.304041757521;11912.583059592873;11467.770644587228;11474.311541307214;11590.42047897585;11598.826017609574;11599.942000289944 03:04:17 INFO - PROCESS | 1655 | __end_tp_report 03:04:17 INFO - PROCESS | 1655 | __start_cc_report 03:04:17 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1265 03:04:17 INFO - PROCESS | 1655 | __end_cc_report 03:04:17 INFO - PROCESS | 1655 | __startTimestamp1473329057336__endTimestamp 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | ------- Summary: start ------- 03:04:17 INFO - PROCESS | 1655 | Number of tests: 6 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5756.95 Median:5964.00 stddev:654.93 (11.0%) stddev-sans-first:627.95 03:04:17 INFO - PROCESS | 1655 | Values: 3300.6 3315.2 3342.3 3380.2 3391.9 5578.6 5715.2 5724.9 5734.6 5746.6 5652.3 5745.2 5759.1 5764.9 5831.1 5169.5 5215.0 5222.4 5246.0 5251.2 5284.7 5288.6 5291.0 5291.4 5309.1 4643.7 5287.9 5306.7 5309.6 5316.4 5145.9 5174.4 5221.3 5235.4 5303.0 5129.4 5163.9 5217.3 5217.4 5232.6 5732.9 5737.9 5760.9 5770.9 5810.5 6295.1 6295.7 6300.1 6304.6 6310.1 6109.2 6256.2 6309.1 6358.9 6371.4 5822.7 5848.6 5852.4 5857.2 5904.8 6303.0 6353.0 6359.0 6369.9 6378.8 6056.3 6125.2 6131.9 6180.7 6223.6 6232.0 6260.2 6281.3 6292.1 6315.1 6259.4 6279.8 6282.0 6298.5 6310.9 6096.2 6116.6 6314.6 6329.7 6337.9 4991.9 4997.9 5003.4 5004.7 5011.7 4447.7 4450.4 4457.7 4468.3 4492.5 5600.7 5737.9 5748.1 5749.9 5783.1 6228.9 6245.6 6270.2 6304.2 6384.7 5733.1 5738.3 5752.4 5758.0 5787.9 5345.9 5429.5 5443.7 5455.8 5461.1 5787.2 6271.9 6317.4 6342.2 6368.1 5300.5 6079.5 6329.9 6340.7 6369.4 6317.7 6347.1 6347.7 6359.6 6376.6 6104.6 6141.9 6148.5 6150.3 6253.6 6324.3 6328.3 6328.9 6337.1 6338.7 4568.0 6110.6 6184.5 6190.4 6193.9 5156.6 5998.2 6067.7 6094.0 6138.2 5963.7 5964.0 5969.2 5975.8 6010.4 5825.2 6012.0 6107.3 6128.3 6164.0 5914.3 5999.9 6045.4 6045.7 6118.6 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66812.65 Median:38225.90 stddev:149662.38 (391.5%) stddev-sans-first:149999.38 03:04:17 INFO - PROCESS | 1655 | Values: 487.5 521.6 540.4 547.0 555.8 29992.4 32292.8 32333.0 32462.8 32465.8 32716.2 40545.4 41795.8 41799.0 44713.1 9715.8 9872.7 9890.7 9890.7 9895.4 9686.3 9785.3 9795.4 9803.1 9806.7 9793.9 9804.2 9825.8 9825.8 9843.0 8880.9 9347.3 9755.2 9779.4 9796.4 9683.8 9750.4 9763.6 9785.2 9794.0 31837.0 38496.0 38610.2 38619.8 38671.6 2914.0 3298.3 3320.6 3343.1 3416.7 29417.7 30453.9 30488.7 30506.1 30526.0 3276.1 3279.9 3360.7 3360.9 3371.3 366347.0 370196.0 370902.0 372488.0 376554.0 56540.7 56727.7 56883.0 56901.9 56951.0 52581.6 55840.4 58932.3 58947.4 58975.7 15836.0 16060.8 16074.0 16084.4 16098.2 12538.4 12592.2 12600.7 12614.6 12615.0 11074.7 14832.4 14949.4 14976.0 14982.9 6350.7 6641.0 6760.0 6787.0 6895.8 712.9 740.7 887.9 927.8 1097.4 28566.7 29179.0 29482.7 29665.3 29727.0 963.9 1016.9 1036.6 1076.7 1126.5 14871.3 14932.8 15028.5 15279.0 15316.9 690383.0 696064.0 696380.0 696581.0 698089.0 54995.0 55154.0 55154.4 55186.0 55260.7 1241.3 1337.3 1377.3 1387.3 1388.4 26851.5 27355.8 30495.5 30685.1 31005.4 46459.3 46968.0 46983.8 47109.0 47117.8 556323.0 558775.0 559268.0 559407.0 560795.0 23287.7 23776.8 23780.3 24400.5 26372.2 46161.3 47557.5 47701.0 47899.3 48531.0 37759.6 37825.2 38201.0 38734.6 39392.0 37150.0 37712.4 38250.8 38473.0 39015.8 32804.5 37860.8 37956.3 37973.1 38600.0 28555.7 29273.7 33598.8 34159.8 34924.8 22413.4 23478.3 24669.0 24729.0 25042.4 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33075.45 Median:25647.18 stddev:86250.17 (336.3%) stddev-sans-first:86457.13 03:04:17 INFO - PROCESS | 1655 | Values: 352.6 371.5 373.6 381.8 403.0 13551.5 15609.9 20017.2 20686.9 21308.8 19863.0 19976.6 20499.6 20686.5 20693.4 5671.1 5743.9 5966.9 6007.8 6008.0 4145.7 4367.0 5828.6 6006.8 6318.6 6533.4 6616.2 6618.4 6632.3 6639.8 6306.0 6516.4 6562.5 6574.0 6620.7 5450.5 5604.4 5678.0 5691.8 5706.2 25611.0 25683.4 25842.9 25975.4 26229.0 2125.4 2182.6 2257.9 2273.8 2372.6 14987.0 15327.0 15521.0 15605.7 15946.4 1822.7 1831.4 1870.4 1873.7 1932.9 115842.8 122636.9 128154.4 128688.4 128845.4 10852.3 10954.5 11305.6 11347.5 11508.0 11742.8 14118.7 14120.9 14154.2 14167.7 7351.6 7946.0 8410.6 8457.3 8586.8 8289.5 8297.7 8334.2 8474.4 8481.1 4361.2 4422.6 4485.4 4509.6 4525.8 1770.5 1806.9 1874.9 1885.7 1912.5 917.3 932.6 956.9 960.4 1012.0 17175.8 19341.1 20709.9 20934.9 20946.0 867.2 902.1 932.0 948.8 985.0 8919.6 9311.7 10044.7 10118.9 10993.5 415989.0 444622.0 445428.0 586894.4 597921.0 138806.0 143365.0 153896.0 154032.2 156073.2 972.6 1001.8 1016.1 1016.6 1021.1 18243.4 19016.6 19034.4 19035.4 19066.4 39463.6 47637.0 51296.7 56974.7 57298.7 78389.6 84715.6 85185.0 85631.0 85636.1 7607.0 7694.3 7848.6 7864.0 8121.7 12182.3 12539.3 12667.3 12726.2 12741.0 10250.1 10849.8 10953.2 10964.3 11040.9 7943.4 10750.1 11117.6 11143.4 11154.4 8448.8 9039.3 10950.3 10967.5 11112.3 7702.3 7942.9 7955.2 8169.9 8180.4 10020.7 10815.5 10851.8 11004.9 11183.4 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5689.86 Median:4797.53 stddev:3197.66 (66.7%) stddev-sans-first:3189.90 03:04:17 INFO - PROCESS | 1655 | Values: 1337.4 1483.6 1677.4 1871.5 1928.8 8415.6 8917.0 8920.1 8934.8 8955.8 7806.9 8029.2 8477.8 8641.6 8652.6 2346.8 2382.8 2386.0 2388.5 2390.3 2045.7 2308.7 2386.1 2387.5 2390.9 2355.7 2367.5 2372.7 2381.3 2384.8 2342.7 2358.3 2361.1 2371.8 2376.0 2333.3 2348.9 2355.5 2355.5 2356.4 8715.2 8763.9 8803.9 8820.9 8867.4 5191.4 5331.8 5333.3 5334.1 5334.2 3138.4 3652.5 3659.8 3725.5 3740.3 1084.5 1088.5 1089.3 1093.9 1101.4 11485.0 11570.4 11580.6 11586.5 11605.4 4505.2 4613.7 4781.6 4792.9 4802.2 8263.5 9812.3 9821.1 9835.6 9888.5 5337.6 5337.9 5340.6 5346.4 5350.3 4419.9 4569.4 4740.4 4848.2 4898.1 3855.7 3868.9 3958.1 3990.8 3992.4 1303.4 1303.7 1308.9 1321.3 1321.8 771.6 844.6 869.7 908.1 920.9 5650.9 5783.3 5896.3 5957.8 6168.4 422.9 427.6 435.7 438.7 438.9 3924.5 3995.1 4002.9 4028.2 4062.6 10262.7 10637.3 10645.4 10809.5 10818.1 10762.3 10770.2 10786.8 10793.7 10806.2 7999.9 8171.1 8202.2 8206.2 8208.3 5687.4 5941.3 6076.5 6155.9 6160.6 9462.2 10018.3 10046.2 10076.3 10084.2 10317.2 10326.5 10332.2 10342.9 10343.2 6981.0 7189.0 7401.0 7515.4 7647.8 7210.3 8197.5 8515.0 8527.1 8560.6 7098.8 7134.2 7323.6 7404.4 7506.8 7345.5 7377.5 7386.1 7404.1 7489.3 6970.0 6979.8 7058.0 7059.6 7060.5 4940.1 4995.6 5014.5 5034.6 5124.4 4891.6 4991.9 5100.7 5212.7 5213.2 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4370.42 Median:4807.33 stddev:1368.12 (28.5%) stddev-sans-first:1337.44 03:04:17 INFO - PROCESS | 1655 | Values: 301.4 304.3 309.8 315.3 317.7 5351.5 5360.2 5370.5 5387.6 5412.9 4437.4 5332.1 5337.1 5368.4 5382.3 3904.9 4025.5 4048.6 4064.6 4074.4 3588.6 3982.5 4066.6 4077.9 4099.8 4046.3 4050.5 4073.1 4074.4 4099.2 3375.5 3717.8 3784.7 4050.7 4079.3 3162.4 3213.4 3361.3 3390.7 3522.3 5058.0 5115.6 5134.0 5144.0 5163.8 3508.2 4353.9 4646.7 4651.3 4670.0 4939.5 5254.0 5509.3 5575.3 5600.9 3594.2 3901.9 3904.3 3907.8 3914.5 4941.8 5212.4 5269.6 5510.6 5693.3 3374.9 3558.7 3850.5 3870.7 3982.0 3575.8 3894.0 4058.5 4062.6 4068.3 4104.4 4154.7 4449.3 4699.7 4702.2 4910.8 5011.9 5128.4 5640.9 5641.3 1128.0 1164.6 1175.0 1317.8 1346.4 777.5 841.6 856.0 856.4 856.7 3849.1 4031.4 4111.7 4325.1 4386.8 4000.6 4158.7 4813.7 4862.1 4871.4 4148.2 4382.1 4384.6 4385.5 4386.3 2114.0 2288.3 2389.6 2478.4 2552.0 4201.5 4314.0 4470.3 4752.0 4945.7 4927.9 5003.4 5035.9 5036.0 5043.5 5041.8 5467.8 5539.6 5915.8 6024.5 4688.5 5808.2 5878.9 5881.8 5913.9 4468.4 5148.0 5327.9 5356.8 5771.6 5793.2 5835.8 5893.4 5970.5 6072.4 3459.5 3525.3 4005.6 4046.6 4088.8 5059.7 5611.2 5809.6 5819.5 5824.9 5264.6 5510.2 5654.8 5689.9 5697.8 4492.4 5646.9 5654.7 5674.0 5765.2 4804.8 4809.9 5082.9 5269.3 5660.5 5107.9 5241.0 5620.3 5627.9 5650.3 5186.9 5549.3 5595.9 5623.3 5636.8 03:04:17 INFO - PROCESS | 1655 | 03:04:17 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25343.10 Median:3550.96 stddev:41029.37 (1155.4%) stddev-sans-first:41102.75 03:04:17 INFO - PROCESS | 1655 | Values: 700.8 740.8 775.6 801.9 824.5 15529.4 16657.1 16683.6 16692.4 16692.8 14950.6 15057.2 15090.4 15096.2 15131.5 692.8 711.3 845.6 859.6 885.1 839.9 847.9 849.3 849.8 851.2 900.2 900.9 901.1 903.0 906.0 895.3 896.2 896.5 897.2 897.5 544.5 674.5 685.0 690.4 694.0 14788.3 14808.2 14839.3 14850.4 14858.7 13497.6 14006.2 14155.4 14172.9 14229.4 12594.4 12959.7 13015.5 13137.1 13497.1 4553.1 4605.3 4613.1 4798.2 4802.4 109626.0 125793.0 128350.0 128696.4 129902.0 10894.6 10951.8 10976.8 10976.8 11490.3 22190.2 22250.4 22278.7 22279.2 22317.0 7392.9 7617.2 7767.4 7796.8 8059.0 4405.1 4440.7 4482.1 4532.6 4605.2 3396.2 3545.3 3550.6 3551.3 3552.7 533.6 646.7 649.4 652.2 652.6 535.9 562.1 565.4 589.0 639.7 8528.6 8702.7 9129.4 9216.2 9280.5 602.0 609.3 622.4 639.5 640.9 4250.7 4465.7 4469.2 4486.3 4558.6 96852.5 97417.0 117182.0 153586.2 157802.2 146757.0 147361.0 150000.0 150605.0 157185.0 120445.4 121250.4 121343.0 122915.0 124829.4 8548.8 8586.2 8724.4 8768.0 8869.1 45859.5 52677.2 54293.7 59458.1 62140.7 78502.6 79111.0 92935.5 94413.5 95064.5 10693.4 13084.7 13139.7 13356.3 13568.8 14527.9 14904.6 15276.3 15305.4 15813.0 11395.6 12693.0 14505.0 14582.0 14739.7 13497.5 13517.0 13853.9 14210.8 14407.0 11447.4 13822.3 13843.2 13890.7 14198.8 11352.4 11380.7 11403.7 11599.3 11912.6 11467.8 11474.3 11590.4 11598.8 11599.9 03:04:17 INFO - PROCESS | 1655 | -------- Summary: end -------- 03:04:17 INFO - PROCESS | 1655 | 03:04:18 INFO - TEST-INFO | 1655: exit 0 03:04:18 INFO - TEST-OK | dromaeo_css | took 1117042ms 03:04:18 INFO - TEST-START | kraken 03:04:18 INFO - operating with platform_type : mac_ 03:04:18 INFO - Initialising browser for kraken test... 03:04:18 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpzCBKGW/profile http://localhost:49265/getInfo.html) 03:04:20 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 03:04:20 INFO - PROCESS | 1661 | colorDepth:24 03:04:20 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 03:04:20 INFO - PROCESS | 1661 | __metrics 03:04:20 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:04:20 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:04:21 INFO - TEST-INFO | 1661: exit 0 03:04:21 INFO - Browser initialized. 03:04:21 INFO - Running cycle 1/1 for kraken test... 03:04:21 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpzCBKGW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:33 INFO - PROCESS | 1662 | RSS: Main: 231968768 03:04:33 INFO - PROCESS | 1662 | 03:04:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:36 INFO - PROCESS | 1662 | RSS: Main: 290770944 03:04:36 INFO - PROCESS | 1662 | 03:04:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 03:04:40 INFO - PROCESS | 1662 | RSS: Main: 287293440 03:04:40 INFO - PROCESS | 1662 | 03:04:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 03:04:44 INFO - PROCESS | 1662 | RSS: Main: 379207680 03:04:44 INFO - PROCESS | 1662 | 03:04:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 03:04:46 INFO - PROCESS | 1662 | RSS: Main: 281382912 03:04:46 INFO - PROCESS | 1662 | 03:04:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:49 INFO - PROCESS | 1662 | RSS: Main: 285089792 03:04:49 INFO - PROCESS | 1662 | 03:04:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 03:04:53 INFO - PROCESS | 1662 | RSS: Main: 322412544 03:04:53 INFO - PROCESS | 1662 | 03:04:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 03:04:56 INFO - PROCESS | 1662 | RSS: Main: 323264512 03:04:56 INFO - PROCESS | 1662 | 03:04:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 03:04:59 INFO - PROCESS | 1662 | RSS: Main: 321933312 03:04:59 INFO - PROCESS | 1662 | 03:05:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:02 INFO - PROCESS | 1662 | RSS: Main: 298663936 03:05:02 INFO - PROCESS | 1662 | 03:05:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:04 INFO - PROCESS | 1662 | RSS: Main: 304664576 03:05:04 INFO - PROCESS | 1662 | 03:05:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:07 INFO - PROCESS | 1662 | RSS: Main: 301469696 03:05:07 INFO - PROCESS | 1662 | 03:05:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:11 INFO - PROCESS | 1662 | RSS: Main: 316968960 03:05:11 INFO - PROCESS | 1662 | 03:05:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:14 INFO - PROCESS | 1662 | RSS: Main: 313307136 03:05:14 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 03:05:16 INFO - PROCESS | 1662 | RSS: Main: 357335040 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | __start_tp_report 03:05:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 03:05:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 03:05:16 INFO - PROCESS | 1662 | |i|pagename|runs| 03:05:16 INFO - PROCESS | 1662 | |0;ai-astar;114;113;116;113;113;113;112;114;114;124 03:05:16 INFO - PROCESS | 1662 | |1;audio-beat-detection;149;110;133;161;108;133;129;110;151;134 03:05:16 INFO - PROCESS | 1662 | |2;audio-dft;185;184;184;185;184;184;185;183;182;185 03:05:16 INFO - PROCESS | 1662 | |3;audio-fft;77;73;76;151;73;82;82;84;140;60 03:05:16 INFO - PROCESS | 1662 | |4;audio-oscillator;82;84;135;69;70;91;116;68;69;116 03:05:16 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;89;86;87;131;131;86;89;87;89;86 03:05:16 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;95;94;94;94;94;95;95;95;94 03:05:16 INFO - PROCESS | 1662 | |7;imaging-desaturate;86;84;88;87;87;86;84;88;87;87 03:05:16 INFO - PROCESS | 1662 | |8;json-parse-financial;54;53;53;53;73;80;80;80;56;54 03:05:16 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;66;66;72;72;73;76;71;69;69;69 03:05:16 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;82;81;85;85;88;84;86;83;85;88 03:05:16 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;140;139;140;138;134;153;129;142;203;129 03:05:16 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;169;168;167;168;167;167;165;169;228;193 03:05:16 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;68;68;67;69;77;85;87;70;67 03:05:16 INFO - PROCESS | 1662 | __end_tp_report 03:05:16 INFO - PROCESS | 1662 | __start_cc_report 03:05:16 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2053 03:05:16 INFO - PROCESS | 1662 | __end_cc_report 03:05:16 INFO - PROCESS | 1662 | __startTimestamp1473329116896__endTimestamp 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | ------- Summary: start ------- 03:05:16 INFO - PROCESS | 1662 | Number of tests: 14 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:3.67 03:05:16 INFO - PROCESS | 1662 | Values: 114.0 113.0 116.0 113.0 113.0 113.0 112.0 114.0 114.0 124.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:133.50 stddev:18.41 (13.8%) stddev-sans-first:18.44 03:05:16 INFO - PROCESS | 1662 | Values: 149.0 110.0 133.0 161.0 108.0 133.0 129.0 110.0 151.0 134.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:0.99 (0.5%) stddev-sans-first:1.00 03:05:16 INFO - PROCESS | 1662 | Values: 185.0 184.0 184.0 185.0 184.0 184.0 185.0 183.0 182.0 185.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.50 stddev:30.24 (39.5%) stddev-sans-first:31.71 03:05:16 INFO - PROCESS | 1662 | Values: 77.0 73.0 76.0 151.0 73.0 82.0 82.0 84.0 140.0 60.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:69.50 stddev:24.14 (34.7%) stddev-sans-first:25.43 03:05:16 INFO - PROCESS | 1662 | Values: 82.0 84.0 135.0 69.0 70.0 91.0 116.0 68.0 69.0 116.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:87.00 stddev:18.44 (21.2%) stddev-sans-first:19.37 03:05:16 INFO - PROCESS | 1662 | Values: 89.0 86.0 87.0 131.0 131.0 86.0 89.0 87.0 89.0 86.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 03:05:16 INFO - PROCESS | 1662 | Values: 93.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.51 03:05:16 INFO - PROCESS | 1662 | Values: 86.0 84.0 88.0 87.0 87.0 86.0 84.0 88.0 87.0 87.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.50 stddev:12.80 (19.8%) stddev-sans-first:13.10 03:05:16 INFO - PROCESS | 1662 | Values: 54.0 53.0 53.0 53.0 73.0 80.0 80.0 80.0 56.0 54.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.50 stddev:3.13 (4.4%) stddev-sans-first:2.91 03:05:16 INFO - PROCESS | 1662 | Values: 66.0 66.0 72.0 72.0 73.0 76.0 71.0 69.0 69.0 69.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.24 03:05:16 INFO - PROCESS | 1662 | Values: 82.0 81.0 85.0 85.0 88.0 84.0 86.0 83.0 85.0 88.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:140.00 stddev:21.61 (15.4%) stddev-sans-first:22.86 03:05:16 INFO - PROCESS | 1662 | Values: 140.0 139.0 140.0 138.0 134.0 153.0 129.0 142.0 203.0 129.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:168.50 stddev:19.95 (11.8%) stddev-sans-first:21.00 03:05:16 INFO - PROCESS | 1662 | Values: 169.0 168.0 167.0 168.0 167.0 167.0 165.0 169.0 228.0 193.0 03:05:16 INFO - PROCESS | 1662 | 03:05:16 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:69.50 stddev:7.72 (11.1%) stddev-sans-first:7.93 03:05:16 INFO - PROCESS | 1662 | Values: 67.0 68.0 68.0 67.0 69.0 77.0 85.0 87.0 70.0 67.0 03:05:16 INFO - PROCESS | 1662 | -------- Summary: end -------- 03:05:16 INFO - PROCESS | 1662 | 03:05:17 INFO - TEST-INFO | 1662: exit 0 03:05:17 INFO - TEST-OK | kraken | took 59689ms 03:05:17 INFO - SUITE-END | took 1176s 03:05:18 INFO - Completed test suite (00:19:37) 03:05:18 INFO - javascript benchmark 03:05:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.6204286507045, 3315.220923083075, 3342.331533693262, 3380.239446124621, 3391.9152021199466, 5578.581606379517, 5715.199872017921, 5724.885502289952, 5734.59857809953, 5746.597738158325, 5652.321721393429, 5745.195672605839, 5759.10733836255, 5764.884702305952, 5831.125331200312, 5169.534741873231, 5215.035218484573, 5222.373315202171, 5246.029484545352, 5251.212318152269, 5284.735763211843, 5288.629795914288, 5291.047611429941, 5291.417944026154, 5309.123994540896, 4643.698159619614, 5287.947120528803, 5306.70813105279, 5309.575233981292, 5316.441773613773, 5145.871353216162, 5174.404943431478, 5221.347331583552, 5235.424103348629, 5302.992431438053, 5129.384473863161, 5163.922541161885, 5217.3217481727515, 5217.373915130209, 5232.607554433433, 5732.8853422931725, 5737.856553586152, 5760.913586296209, 5770.88458230833, 5810.535157187415, 6295.0872123542285, 6295.7166927487915, 6300.1494798202575, 6304.621722696653, 6310.053491976194, 6109.16175461965, 6256.1866957295715, 6309.116723658692, 6358.904616430757, 6371.426571608577, 5822.708864556797, 5848.590598658138, 5852.444017818258, 5857.179994800731, 5904.793332233351, 6303.0, 6352.951762959153, 6359.0, 6369.872602547923, 6378.77674281398, 6056.273247210363, 6125.20492926512, 6131.877362452726, 6180.721867515973, 6223.626582405071, 6232.034034724625, 6260.186175797117, 6281.309056003836, 6292.087647291117, 6315.052742088632, 6259.405356491126, 6279.811605651837, 6281.963476026496, 6298.496120310364, 6310.905336419957, 6096.194094249989, 6116.579253789288, 6314.62112273265, 6329.651869147241, 6337.904931426032, 4991.850244492671, 4997.90004199914, 5003.424606170337, 5004.699718016931, 5011.674241174312, 4447.710898791568, 4450.421445212167, 4457.710248833815, 4468.3074123510905, 4492.460904691393, 5600.719964001783, 5737.8565535861935, 5748.080307150836, 5749.942500574941, 5783.074708046776, 6228.937710622836, 6245.594036387711, 6270.2475702915945, 6304.180456540712, 6384.7126879290545, 5733.122546990553, 5738.282714660668, 5752.395998420189, 5758.0, 5787.884242315215, 5345.86635334112, 5429.511343979061, 5443.700596467233, 5455.754491047913, 5461.0716178249795, 5787.2187254720075, 6271.905921411091, 6317.431431171033, 6342.207224096988, 6368.14030105939, 5300.469953004668, 6079.452849243589, 6329.8904288584745, 6340.651264180515, 6369.394907483782, 6317.6958172255445, 6347.079673447232, 6347.650879201688, 6359.618422894641, 6376.649284289409, 6104.572679912541, 6141.915626108766, 6148.50811935053, 6150.323464419, 6253.593516421418, 6324.335944725737, 6328.335524769833, 6328.936710632835, 6337.081123237197, 6338.714757836001, 4568.0, 6110.633361998294, 6184.505239580732, 6190.350013248544, 6193.876122477615, 5156.61325400604, 5998.160257563857, 6067.666278354556, 6093.987814007425, 6138.2044803098925, 5963.671998040149, 5964.0, 5969.194158788508, 5975.760969561169, 6010.398960103955, 5825.155352473952, 6012.0, 6107.328193898757, 6128.295246046761, 6163.96918015425, 5914.349421563538, 5999.880002400015, 6045.365236650265, 6045.697715114315, 6118.571699980958], "value": 5715.442658226934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.51005239734064, 521.6192179708812, 540.3785646506519, 546.985342190237, 555.7526900529266, 29992.400151996946, 32292.838535807317, 32333.0, 32462.837685811595, 32465.837670811612, 32716.182095447624, 40545.39181912266, 41795.79102104485, 41799.0, 44713.10573788531, 9715.805683886318, 9872.703818885446, 9890.653827116052, 9890.653827116052, 9895.356801807895, 9686.273529485317, 9785.266105042114, 9795.412275263507, 9803.117719405253, 9806.705798826046, 9793.853092203623, 9804.166645835112, 9825.754356141118, 9825.754356141118, 9843.0, 8880.8667869982, 9347.298952578583, 9755.170810481117, 9779.364341317792, 9796.363236389612, 9683.757906052335, 9750.414975101447, 9763.560639771227, 9785.168260697848, 9794.02059794022, 31837.0, 38496.0, 38610.227795443934, 38619.806900965596, 38671.61328386708, 2914.0383673387732, 3298.290867463507, 3320.6257525868878, 3343.114074770188, 3416.6754158355166, 29417.70582294171, 30453.934112305964, 30488.69511304881, 30506.08481745551, 30526.0, 3276.1318250663594, 3279.8852040178717, 3360.6807353301397, 3360.949585756191, 3371.342588195303, 366347.0, 370196.0, 370902.0, 372488.0, 376554.0, 56540.71729641408, 56727.71636141793, 56883.0, 56901.861962760515, 56951.0, 52581.6338264779, 55840.441595584336, 58932.285417166524, 58947.41052589505, 58975.70512147497, 15836.0, 16060.839391606169, 16074.035557866566, 16084.43704470338, 16098.195090245441, 12538.435770390355, 12592.181508201938, 12600.684982875318, 12614.558490452973, 12614.990800735919, 11074.723131921766, 14832.406703731946, 14949.40202391914, 14976.026558273677, 14982.876284278722, 6350.714217860207, 6640.966795165993, 6759.966200168968, 6786.966065169741, 6895.793126206222, 712.9059880120303, 740.6704016712619, 887.933404994628, 927.79124696944, 1097.4183682648209, 28566.714332856405, 29179.0, 29482.705172947997, 29665.25836854096, 29727.0, 963.8602402651576, 1016.9338992965434, 1036.6060896859144, 1076.7200527862813, 1126.4987080749152, 14871.33079011447, 14932.776008359884, 15028.549143525712, 15279.0, 15316.923415382851, 690383.0, 696064.0, 696380.0, 696581.0, 698089.0, 54995.0, 55154.0, 55154.44845551573, 55186.0, 55260.72369638126, 1241.3420886929941, 1337.297918592766, 1377.2975782351073, 1387.3202130955558, 1388.4099257815387, 26851.462970740085, 27355.76899039508, 30495.54256686107, 30685.07944761661, 31005.379892402478, 46459.30311045405, 46968.0, 46983.76508117437, 47109.0, 47117.822054448916, 556323.0, 558775.0, 559268.0, 559407.0, 560795.0, 23287.650685239398, 23776.762232378147, 23780.286591402284, 24400.51198975975, 26372.208833735018, 46161.30758038565, 47557.524424756695, 47701.0, 47899.28151077667, 48531.0, 37759.62240377671, 37825.24349512939, 38201.0, 38734.612653873104, 39392.0, 37150.0, 37712.43431348587, 38250.80874595609, 38473.038174044756, 39015.80492097521, 32804.50793238151, 37860.810695947446, 37956.291966861005, 37973.05067373227, 38600.0, 28555.714442855304, 29273.7072629271, 33598.83200583982, 34159.82920085483, 34924.825375872955, 22413.43966400853, 23478.295651130495, 24669.01323947094, 24729.0, 25042.37394065163], "value": 19101.184592821406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.56810407251135, 371.4947671167213, 373.61144409813795, 381.7575839342019, 402.9939550906737, 13551.457941682333, 15609.92195039026, 20017.1993120275, 20686.896565517152, 21308.786912130894, 19863.006849657533, 19976.600467990633, 20499.590008199826, 20686.48283792906, 20693.379198624065, 5671.120976248688, 5743.942560574404, 5966.9403305967035, 6007.849803754897, 6008.0, 4145.709800313979, 4367.0, 5828.6211396259105, 6006.759729610811, 6318.589291696025, 6533.379328963741, 6616.206055273374, 6618.404343609074, 6632.30360812115, 6639.800805975829, 6306.0, 6516.446102081305, 6562.540622156451, 6574.046763219354, 6620.668966551653, 5450.4822041906355, 5604.3835178130375, 5677.971610141964, 5691.800786972436, 5706.229658996024, 25611.0, 25683.35791605206, 25842.87078564595, 25975.350616234555, 26229.0, 2125.362391282609, 2182.6289530779804, 2257.864528128301, 2273.8067264282554, 2372.6203807390907, 14987.0, 15327.0, 15521.0, 15605.68788624221, 15946.362145514166, 1822.6992546229856, 1831.4414103698366, 1870.3734249026593, 1873.690841011245, 1932.884026958387, 115842.84157158405, 122636.94616899846, 128154.3592282042, 128688.3565582166, 128845.35577322147, 10852.255971689754, 10954.452277386099, 11305.569302599815, 11347.48936297852, 11508.0, 11742.823857642143, 14118.71762564743, 14120.929395352958, 14154.221517816413, 14167.71664566703, 7351.558906465629, 7945.960270198612, 8410.570203065494, 8457.323414126855, 8586.78533036679, 8289.502629842229, 8297.709580164665, 8334.20825021622, 8474.406791524534, 8481.109483504266, 4361.193179261847, 4422.624076953431, 4485.416895803524, 4509.6392288616835, 4525.841595544141, 1770.4954088084835, 1806.9006204658608, 1874.8968806715488, 1885.660581095416, 1912.5123093611319, 917.2570218123342, 932.6083045121065, 956.9425834449955, 960.3661583354952, 1011.9696409107738, 17175.828241717674, 19341.12964916582, 20709.896450517652, 20934.895325523274, 20946.0, 867.1891781184613, 902.120432578231, 931.9767005824773, 948.7817801905601, 985.0346660272972, 8919.554022298858, 9311.674091406769, 10044.748881278027, 10118.898811011943, 10993.505292261867, 415989.0, 444622.0, 445428.0, 586894.3931682056, 597921.0, 138806.0, 143365.0, 153896.0, 154032.22983885233, 156073.2196339011, 972.6401231544373, 1001.834697274956, 1016.1413605503337, 1016.6492560066913, 1021.1218352217087, 18243.361482348053, 19016.619667606847, 19034.428967131007, 19035.428937131906, 19066.428007159808, 39463.60536394599, 47637.0, 51296.74351628218, 56974.71512642576, 57298.713506433865, 78389.60805196165, 84715.57642211749, 85185.0, 85631.0, 85636.1436385653, 7607.0, 7694.307512323918, 7848.568328741974, 7864.0, 8121.675132994614, 12182.269063856196, 12539.310337931502, 12667.303298318313, 12726.23642581411, 12741.0, 10250.128739056965, 10849.837252441062, 10953.178511611502, 10964.28732132409, 11040.889591103985, 7943.364530837634, 10750.139988801033, 11117.552399324435, 11143.387113708824, 11154.43448006979, 8448.788780280542, 9039.276857851488, 10950.34297942126, 10967.451627418437, 11112.333260004425, 7702.306792388487, 7942.880856787268, 7955.164707705608, 8169.87583228353, 8180.386471014579, 10020.69937901864, 10815.513301901276, 10851.837222441827, 11004.889951100387, 11183.384913829817], "value": 9552.81860073658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.4048548395965, 1483.584596313032, 1677.379369633236, 1871.4759867237178, 1928.7878333383326, 8415.579221038946, 8916.955415222916, 8920.063393343695, 8934.776630584238, 8955.820883582324, 7806.882896756553, 8029.237222463871, 8477.830443391143, 8641.611127499262, 8652.567371631409, 2346.7770561796647, 2382.7855493005627, 2386.0217310902535, 2388.486475407787, 2390.270967354956, 2045.7340545729035, 2308.665243539686, 2386.1409892438796, 2387.510560335136, 2390.8924098415528, 2355.729091154522, 2367.490989437271, 2372.7152741671025, 2381.261808839257, 2384.8092152627746, 2342.7305859825997, 2358.292512246328, 2361.0791791201445, 2371.8221133414977, 2376.0020791267707, 2333.3116730564525, 2348.8825558722165, 2355.5053438777877, 2355.5406695694346, 2356.375560476475, 8715.215630593213, 8763.912360876373, 8803.867941980876, 8820.8676869847, 8867.379283450162, 5191.377034755816, 5331.760070796823, 5333.333333333333, 5334.146536554172, 5334.199870019489, 3138.4037032963665, 3652.470391793175, 3659.8170091495317, 3725.5156829612247, 3740.251949610089, 1084.4902895639116, 1088.4775307852196, 1089.2756317049152, 1093.8796732359433, 1101.427257825934, 11485.0, 11570.421478926104, 11580.594679186188, 11586.47860846264, 11605.4197290136, 4505.234110201273, 4613.746243956614, 4781.617470602343, 4792.904141917142, 4802.159622066124, 8263.462874913112, 9812.264080194014, 9821.116099550933, 9835.606575737034, 9888.456134912649, 5337.599680024014, 5337.866553336197, 5340.599455040888, 5346.385165705916, 5350.304460420199, 4419.9337009944875, 4569.405977222939, 4740.383750112533, 4848.248521479177, 4898.069366820293, 3855.6722678572637, 3868.903277418087, 3958.129211573449, 3990.8004599770475, 3992.404936791109, 1303.4395210059765, 1303.7262174943178, 1308.9345532723326, 1321.3261236769124, 1321.841379034522, 771.5602106799183, 844.6072576252072, 869.7173418638968, 908.1055160666738, 920.8756817829641, 5650.943490565124, 5783.306003279633, 5896.292444906553, 5957.76168953237, 6168.383161683796, 422.9175310814423, 427.58737818005153, 435.6906596316587, 438.68195558220674, 438.92318844202134, 3924.50943632046, 3995.06116062725, 4002.8999275017777, 4028.2144981728866, 4062.614051665087, 10262.692119236435, 10637.255392122477, 10645.414502202299, 10809.459527023617, 10818.134549236041, 10762.300450470695, 10770.246082774287, 10786.78426431467, 10793.67618971432, 10806.18953578469, 7999.880001799977, 8171.101178870438, 8202.17978202175, 8206.22040906113, 8208.302294305051, 5687.43125687428, 5941.31674857397, 6076.513878889767, 6155.876882462415, 6160.568760186744, 9462.195713364441, 10018.298719089886, 10046.196304295785, 10076.294659373774, 10084.193264538673, 10317.226208034277, 10326.535305911102, 10332.173426126043, 10342.896571034193, 10343.224258180517, 6980.965095174694, 7189.0, 7401.037865077506, 7515.436342274242, 7647.847043058996, 7210.2789721027475, 8197.549134797644, 8515.020772610982, 8527.147285271423, 8560.571971401281, 7098.787036388917, 7134.1795693495915, 7323.6338183089565, 7404.444666649915, 7506.774796756106, 7345.485815992829, 7377.4835761498325, 7386.0767404074495, 7404.111506619241, 7489.251074892467, 6969.965150174216, 6979.790606281819, 7058.047163633049, 7059.61172135517, 7060.505764596634, 4940.11078005948, 4995.550400463976, 5014.548690617862, 5034.597232221487, 5124.436312005751, 4891.63312751538, 4991.925121123259, 5100.69395836251, 5212.739363031757, 5213.244079608511], "value": 4496.939915149777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.42578388170534, 304.3122543052702, 309.8264971615896, 315.34251086484676, 317.66962359146487, 5351.464853514652, 5360.249565060894, 5370.516653501184, 5387.568994480442, 5412.9458705412935, 4437.378766972626, 5332.080920523412, 5337.11937530307, 5368.382635996862, 5382.327209098863, 3904.906626144684, 4025.476688030552, 4048.615381538764, 4064.5732198119217, 4074.3888416737577, 3588.6052534221344, 3982.5021872265966, 4066.573009833969, 4077.8980525486804, 4099.754014759109, 4046.312126938413, 4050.513938327405, 4073.083556199846, 4074.409210664452, 4099.221147981874, 3375.476801095834, 3717.814109294538, 3784.678302344304, 4050.7164498485117, 4079.2657321682086, 3162.414953233659, 3213.4376484115187, 3361.2605226850055, 3390.728741700683, 3522.2779330237495, 5057.963117560891, 5115.590752739772, 5133.973205358906, 5144.019552472288, 5163.845084647466, 3508.2106526031694, 4353.869383918487, 4646.746328030902, 4651.3255577941345, 4669.999999999966, 4939.518144556619, 5254.0, 5509.311336082989, 5575.275214222166, 5600.919494278171, 3594.1733401317583, 3901.882943511699, 3904.3362628353248, 3907.808118523849, 3914.451976723261, 4941.838667913037, 5212.400573934008, 5269.6311258211945, 5510.586705997066, 5693.28833895763, 3374.865005399806, 3558.6797188252663, 3850.537935447764, 3870.651641352292, 3981.980090099531, 3575.80333081683, 3893.980530097331, 4058.5332686740812, 4062.6343629073526, 4068.270984831435, 4104.42914664244, 4154.709170358106, 4449.310356894686, 4699.694519856198, 4702.224133018082, 4910.779014944336, 5011.945102507954, 5128.435872054071, 5640.8871822563315, 5641.26663533738, 1128.0298942909092, 1164.6447833410891, 1175.0129890891521, 1317.8403005355226, 1346.4344975110282, 777.4868586732729, 841.6113412868693, 855.9871601925976, 856.4005196362571, 856.6616186606255, 3849.0946981244465, 4031.3952907064177, 4111.691623128278, 4325.118573420509, 4386.780660967002, 4000.6399424051974, 4158.690012646007, 4813.735244561512, 4862.107046307441, 4871.391076115486, 4148.170365926827, 4382.101669157815, 4384.610387338908, 4385.473743150842, 4386.298192289219, 2113.9577208455744, 2288.2791920544973, 2389.6140238661533, 2478.3542770553045, 2552.0, 4201.495820501559, 4313.986213239886, 4470.284754439274, 4751.95248047522, 4945.711102117124, 4927.926081108714, 5003.374578177728, 5035.917277785294, 5035.974820125949, 5043.469571300105, 5041.773120209599, 5467.753951072212, 5539.612227144223, 5915.792947246826, 6024.487918526975, 4688.484266730725, 5808.21589085485, 5878.853623543368, 5881.7647294107755, 5913.924759125317, 4468.391379103455, 5148.021875843578, 5327.866803329948, 5356.812511562077, 5771.624844385102, 5793.217915581343, 5835.79574714883, 5893.44012318829, 5970.5223582114195, 6072.423119803611, 3459.4605400596492, 3525.2773181498246, 4005.599440055971, 4046.615571520701, 4088.7955602219176, 5059.747012649426, 5611.214429979887, 5809.622374545641, 5819.486933397263, 5824.912626310524, 5264.605154613343, 5510.197963405238, 5654.802081927113, 5689.886202276014, 5697.829065128053, 4492.415985921809, 5646.85882852932, 5654.688992105309, 5674.0, 5765.221695071112, 4804.765783910499, 4809.9038019240115, 5082.872928176826, 5269.262303277621, 5660.499967508696, 5107.948920510896, 5240.978009288152, 5620.325560932714, 5627.945799783131, 5650.3219613646625, 5186.9221961669855, 5549.334079910436, 5595.944040559542, 5623.325200975909, 5636.830895073154], "value": 3935.236806002023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.8458139209374, 740.8259059121106, 775.6393277126135, 801.9278264956152, 824.521777369126, 15529.378824847006, 16657.083860387705, 16683.582910427245, 16692.41576544821, 16692.83307166931, 14950.626234344147, 15057.17185554794, 15090.39638414462, 15096.245187740597, 15131.54605361841, 692.8267933016746, 711.3384552366298, 845.6067928413302, 859.5916939453741, 885.1148851148852, 839.9034111077212, 847.9236868681818, 849.3205435651485, 849.8130411309502, 851.1998721202082, 900.2168113741054, 900.860366643168, 901.1169054326764, 903.0472851142042, 906.0305473143738, 895.3329769321832, 896.2426749396749, 896.4755617963499, 897.2328658996595, 897.5377680494518, 544.4990608640061, 674.5177198303237, 684.9863002739917, 690.4096997067535, 693.968771405288, 14788.334524946404, 14808.185549794756, 14839.25803709821, 14850.405983760636, 14858.702825943528, 13497.595072147753, 14006.22965736884, 14155.43378264868, 14172.92913535436, 14229.359678814479, 12594.37028148589, 12959.67600809978, 13015.544455944091, 13137.08806655623, 13497.12268702541, 4553.089382123589, 4605.309203619484, 4613.146567884952, 4798.184308667535, 4802.447718512346, 109625.9999999992, 125793.0, 128350.0, 128696.35651821774, 129902.0, 10894.61868834587, 10951.780964380827, 10976.755341474747, 10976.780464390667, 11490.310581365145, 22190.223342183268, 22250.44373890633, 22278.66328020324, 22279.220227291968, 22316.995735191955, 7392.889106663404, 7617.200193979663, 7767.417443691746, 7796.805079873048, 8058.959705201553, 4405.140997505519, 4440.7335559866515, 4482.058767658763, 4532.614727748112, 4605.194091034055, 3396.1679388549965, 3545.308664810337, 3550.609432962372, 3551.3074950384944, 3552.7335449841366, 533.6157966264284, 646.7057488842565, 649.3863299182227, 652.2140820311513, 652.5921299188008, 535.9383670877899, 562.1343131577325, 565.3922033813667, 588.9558283128782, 639.7441023590508, 8528.616212270463, 8702.73810297516, 9129.406588571721, 9216.157706236263, 9280.489573073546, 601.9969900150471, 609.3248463086873, 622.3682961793783, 639.48840927258, 640.9487241020707, 4250.692562032748, 4465.665075119379, 4469.195544801902, 4486.3494793254795, 4558.589726924526, 96852.54721179188, 97417.0, 117182.0, 153586.23206883893, 157802.2109889443, 146757.0, 147361.0, 150000.0, 150605.0, 157185.0, 120445.39777301233, 121250.39374803069, 121343.0, 122915.0, 124829.37585312016, 8548.829023419621, 8586.184312490303, 8724.43291186071, 8768.0, 8869.11308869108, 45859.54140458553, 52677.20984185164, 54293.72853135709, 59458.108128378975, 62140.689296553224, 78502.6074869622, 79111.0, 92935.53532232296, 94413.5279323599, 95064.52467737618, 10693.411862347646, 13084.738305234032, 13139.737205256033, 13356.265405402795, 13568.796468053184, 14527.85472145265, 14904.552863414116, 15276.312565934782, 15305.363516110692, 15812.97215680977, 11395.601153959571, 12693.048021398248, 14505.0, 14582.0, 14739.705205896036, 13497.527586534425, 13517.0, 13853.861461385257, 14210.78683819723, 14406.991510594158, 11447.427628618703, 13822.308884555932, 13843.169409835442, 13890.722185556031, 14198.787018194529, 11352.432378381212, 11380.658580242605, 11403.657890263305, 11599.304041757521, 11912.583059592873, 11467.770644587228, 11474.311541307214, 11590.42047897585, 11598.826017609574, 11599.942000289944], "value": 7877.6220307009025, "unit": "score"}], "name": "dromaeo_css", "value": 7251.512772032293, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 113.0, 113.0, 113.0, 112.0, 114.0, 114.0, 124.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 133.0, 161.0, 108.0, 133.0, 129.0, 110.0, 151.0, 134.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 185.0, 184.0, 184.0, 185.0, 183.0, 182.0, 185.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 76.0, 151.0, 73.0, 82.0, 82.0, 84.0, 140.0, 60.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 135.0, 69.0, 70.0, 91.0, 116.0, 68.0, 69.0, 116.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 131.0, 131.0, 86.0, 89.0, 87.0, 89.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 87.0, 87.0, 86.0, 84.0, 88.0, 87.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 73.0, 80.0, 80.0, 80.0, 56.0, 54.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 72.0, 73.0, 76.0, 71.0, 69.0, 69.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 85.0, 85.0, 88.0, 84.0, 86.0, 83.0, 85.0, 88.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 140.0, 138.0, 134.0, 153.0, 129.0, 142.0, 203.0, 129.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 167.0, 168.0, 167.0, 167.0, 165.0, 169.0, 228.0, 193.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 69.0, 77.0, 85.0, 87.0, 70.0, 67.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1498.9999999999998, "alertThreshold": 2.0}]} 03:05:18 INFO - Return code: 0 03:05:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:05:18 INFO - # TBPL SUCCESS # 03:05:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:05:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:05:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:05:18 INFO - 2016-09-08 03:05:18.225 screenresolution[1666:10484] starting screenresolution argv=screenresolution get 03:05:18 INFO - 2016-09-08 03:05:18.228 screenresolution[1666:10484] Display 0: 1600x1200x32@60 03:05:18 INFO - 2016-09-08 03:05:18.234 screenresolution[1667:10487] starting screenresolution argv=screenresolution list 03:05:18 INFO - Available Modes on Display 0 03:05:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:05:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:05:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:05:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:05:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:05:18 INFO - Intel Iris: 03:05:18 INFO - Chipset Model: Intel Iris 03:05:18 INFO - Type: GPU 03:05:18 INFO - Bus: Built-In 03:05:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:05:18 INFO - Vendor: Intel (0x8086) 03:05:18 INFO - Device ID: 0x0a2e 03:05:18 INFO - Revision ID: 0x0009 03:05:18 INFO - Displays: 03:05:18 INFO - Display: 03:05:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:05:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:05:18 INFO - Display Serial Number: 1600x1200 60 03:05:18 INFO - Main Display: Yes 03:05:18 INFO - Mirror: Off 03:05:18 INFO - Online: Yes 03:05:18 INFO - Rotation: Supported 03:05:18 INFO - Return code: 0 03:05:18 INFO - Running post-action listener: _resource_record_post_action 03:05:18 INFO - [mozharness: 2016-09-08 10:05:18.469628Z] Finished run-tests step (success) 03:05:18 INFO - Running post-run listener: _resource_record_post_run 03:05:18 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31800320; Write bytes: 706328064; Read time: 319; Write time: 1903 03:05:18 INFO - TinderboxPrint: CPU usage
53.7% 03:05:18 INFO - TinderboxPrint: I/O read bytes / time
31,800,320 / 319 03:05:18 INFO - TinderboxPrint: I/O write bytes / time
706,328,064 / 1,903 03:05:18 INFO - TinderboxPrint: CPU idle
2,246.2 (46.3%) 03:05:18 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 03:05:18 INFO - TinderboxPrint: CPU user
1,633.8 (33.7%) 03:05:18 INFO - TinderboxPrint: Swap in / out
432,979,968 / 0 03:05:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396249600; Write bytes: 389908480; Read time: 29561; Write time: 710 03:05:18 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29932544; Write bytes: 296245248; Read time: 299; Write time: 1144 03:05:18 INFO - Running post-run listener: _upload_blobber_files 03:05:18 INFO - Blob upload gear active. 03:05:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:05:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:20 INFO - (blobuploader) - INFO - Done attempting. 03:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:05:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:21 INFO - (blobuploader) - INFO - Done attempting. 03:05:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:05:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:24 INFO - (blobuploader) - INFO - Done attempting. 03:05:24 INFO - (blobuploader) - INFO - Iteration through files over. 03:05:24 INFO - Return code: 0 03:05:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:05:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:05:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3290a0b88bf706e37382ee1ce5615a16be169c7cf3628c74a0eaa9688623876704e6083d8bb078623affa45a278385011fa26554f71598c042d6fb216af1a82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af628225293e5d9d308d27f4fd5d08dcd72433d7107efdb151f732398cf1ae61ace8a7ff72a639e8cf659bfbcfd5996271fb1a7580dc9eb7ed5e7cb1a508c206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70408c6a18a97d0e0119ee6bfaf08e38fed86eb1a305b4d49959afd4ac6b3595d87aa0414d63f21341e28c5a50f474ca51cd494534894a61b5c99f33c13813cf"} 03:05:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:05:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:05:24 INFO - Contents: 03:05:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3290a0b88bf706e37382ee1ce5615a16be169c7cf3628c74a0eaa9688623876704e6083d8bb078623affa45a278385011fa26554f71598c042d6fb216af1a82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af628225293e5d9d308d27f4fd5d08dcd72433d7107efdb151f732398cf1ae61ace8a7ff72a639e8cf659bfbcfd5996271fb1a7580dc9eb7ed5e7cb1a508c206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70408c6a18a97d0e0119ee6bfaf08e38fed86eb1a305b4d49959afd4ac6b3595d87aa0414d63f21341e28c5a50f474ca51cd494534894a61b5c99f33c13813cf"} 03:05:24 INFO - Running post-run listener: copy_logs_to_upload_dir 03:05:24 INFO - Copying logs to upload dir... 03:05:24 INFO - mkdir: /builds/slave/test/build/upload/logs 03:05:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.388213 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-08 03:05:24.985199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-08 03:05:24.992837) ========= 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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3290a0b88bf706e37382ee1ce5615a16be169c7cf3628c74a0eaa9688623876704e6083d8bb078623affa45a278385011fa26554f71598c042d6fb216af1a82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af628225293e5d9d308d27f4fd5d08dcd72433d7107efdb151f732398cf1ae61ace8a7ff72a639e8cf659bfbcfd5996271fb1a7580dc9eb7ed5e7cb1a508c206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70408c6a18a97d0e0119ee6bfaf08e38fed86eb1a305b4d49959afd4ac6b3595d87aa0414d63f21341e28c5a50f474ca51cd494534894a61b5c99f33c13813cf"} build_url:https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3290a0b88bf706e37382ee1ce5615a16be169c7cf3628c74a0eaa9688623876704e6083d8bb078623affa45a278385011fa26554f71598c042d6fb216af1a82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af628225293e5d9d308d27f4fd5d08dcd72433d7107efdb151f732398cf1ae61ace8a7ff72a639e8cf659bfbcfd5996271fb1a7580dc9eb7ed5e7cb1a508c206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70408c6a18a97d0e0119ee6bfaf08e38fed86eb1a305b4d49959afd4ac6b3595d87aa0414d63f21341e28c5a50f474ca51cd494534894a61b5c99f33c13813cf"}' ========= master_lag: 1.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-08 03:05:26.399101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 03:05:26.399462) ========= 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.NMlWxdKZC9/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.JrAqd0BqUQ/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005186 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 03:05:26.506870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 03:05:26.507141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 03:05:26.516759) ========= ========= Total master_lag: 1.94 =========