builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0269 starttime: 1486398369.01 results: success (0) buildid: 20170206070950 builduid: 249cc5094acb4b0e889774d063e27583 revision: 4f8f9621e75b23ba8f2546cc081df6981f46b13d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.007001) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.007691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.007959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.094495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.094835) ========= 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.XERcr2VNkF/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.65wZrS5GCs/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 --2017-02-06 08:26:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 75.9M=0s 2017-02-06 08:26:09 (75.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.707568 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.825865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.826183) ========= 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.XERcr2VNkF/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.65wZrS5GCs/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.019684 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:09.875359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 08:26:09.875774) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f8f9621e75b23ba8f2546cc081df6981f46b13d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f8f9621e75b23ba8f2546cc081df6981f46b13d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XERcr2VNkF/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.65wZrS5GCs/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 2017-02-06 08:26:09,968 truncating revision to first 12 chars 2017-02-06 08:26:09,968 Setting DEBUG logging. 2017-02-06 08:26:09,968 attempt 1/10 2017-02-06 08:26:09,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f8f9621e75b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 08:26:10,855 unpacking tar archive at: mozilla-aurora-4f8f9621e75b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.147921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 08:26:11.047094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:11.047418) ========= script_repo_revision: 4f8f9621e75b23ba8f2546cc081df6981f46b13d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:11.047821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:11.048148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:26:11.067991) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-06 08:26:11.068401) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XERcr2VNkF/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.65wZrS5GCs/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:26:11 INFO - MultiFileLogger online at 20170206 08:26:11 in /builds/slave/test 08:26:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:26:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:11 INFO - {'append_to_log': False, 08:26:11 INFO - 'base_work_dir': '/builds/slave/test', 08:26:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:26:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:11 INFO - 'branch': 'Mozilla-Aurora', 08:26:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:11 INFO - 'config_files': ('talos/mac_config.py',), 08:26:11 INFO - 'default_actions': ('clobber', 08:26:11 INFO - 'read-buildbot-config', 08:26:11 INFO - 'download-and-extract', 08:26:11 INFO - 'populate-webroot', 08:26:11 INFO - 'create-virtualenv', 08:26:11 INFO - 'install', 08:26:11 INFO - 'run-tests'), 08:26:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:11 INFO - 'download_minidump_stackwalk': True, 08:26:11 INFO - 'download_symbols': 'ondemand', 08:26:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:11 INFO - 'installer_path': 'installer.exe', 08:26:11 INFO - 'log_level': 'info', 08:26:11 INFO - 'log_name': 'talos', 08:26:11 INFO - 'log_to_console': True, 08:26:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:26:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:26:11 INFO - 'opt_config_files': (), 08:26:11 INFO - 'pip_index': False, 08:26:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:11 INFO - 'cmd': ('bash', 08:26:11 INFO - '-c', 08:26:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:11 INFO - 'enabled': True, 08:26:11 INFO - 'halt_on_failure': False, 08:26:11 INFO - 'name': 'check_screen_resolution'},), 08:26:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:11 INFO - 'cmd': ('bash', 08:26:11 INFO - '-c', 08:26:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:11 INFO - 'enabled': True, 08:26:11 INFO - 'halt_on_failure': False, 08:26:11 INFO - 'name': 'check_screen_resolution'},), 08:26:11 INFO - 'run_cmd_checks_enabled': True, 08:26:11 INFO - 'sps_profile': False, 08:26:11 INFO - 'sps_profile_interval': 0, 08:26:11 INFO - 'suite': 'dromaeojs', 08:26:11 INFO - 'system_bits': '32', 08:26:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:11 INFO - 'title': 't-yosemite-r7-0269', 08:26:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:11 INFO - 'use_talos_json': True, 08:26:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:11 INFO - 'work_dir': 'build'} 08:26:11 INFO - [mozharness: 2017-02-06 16:26:11.280581Z] Running clobber step. 08:26:11 INFO - Running pre-action listener: _resource_record_pre_action 08:26:11 INFO - Running main action method: clobber 08:26:11 INFO - rmtree: /builds/slave/test/build 08:26:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:12 INFO - Running post-action listener: _resource_record_post_action 08:26:12 INFO - [mozharness: 2017-02-06 16:26:12.941373Z] Finished clobber step (success) 08:26:12 INFO - [mozharness: 2017-02-06 16:26:12.941536Z] Running read-buildbot-config step. 08:26:12 INFO - Running pre-action listener: _resource_record_pre_action 08:26:12 INFO - Running main action method: read_buildbot_config 08:26:12 INFO - Using buildbot properties: 08:26:12 INFO - { 08:26:12 INFO - "project": "", 08:26:12 INFO - "product": "firefox", 08:26:12 INFO - "script_repo_revision": "production", 08:26:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:26:12 INFO - "repository": "", 08:26:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:26:12 INFO - "buildid": "20170206070950", 08:26:12 INFO - "pgo_build": "False", 08:26:12 INFO - "basedir": "/builds/slave/test", 08:26:12 INFO - "buildnumber": 86, 08:26:12 INFO - "slavename": "t-yosemite-r7-0269", 08:26:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:26:12 INFO - "platform": "yosemite_r7", 08:26:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:26:12 INFO - "branch": "mozilla-aurora", 08:26:12 INFO - "repo_path": "releases/mozilla-aurora", 08:26:12 INFO - "revision": "4f8f9621e75b23ba8f2546cc081df6981f46b13d", 08:26:12 INFO - "stage_platform": "macosx64", 08:26:12 INFO - "builduid": "249cc5094acb4b0e889774d063e27583", 08:26:12 INFO - "slavebuilddir": "test" 08:26:12 INFO - } 08:26:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:26:12 INFO - Running post-action listener: _resource_record_post_action 08:26:12 INFO - [mozharness: 2017-02-06 16:26:12.944757Z] Finished read-buildbot-config step (success) 08:26:12 INFO - [mozharness: 2017-02-06 16:26:12.944868Z] Running download-and-extract step. 08:26:12 INFO - Running pre-action listener: _resource_record_pre_action 08:26:12 INFO - Running main action method: download_and_extract 08:26:12 INFO - mkdir: /builds/slave/test/build/tests 08:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:12 INFO - trying https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:26:12 INFO - Downloading https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:26:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:26:14 INFO - Downloaded 1199 bytes. 08:26:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:26:14 INFO - Using the following test package requirements: 08:26:14 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:26:14 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:26:14 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:26:14 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'jsshell-mac.zip'], 08:26:14 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:26:14 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:26:14 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:26:14 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:26:14 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:26:14 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:26:14 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:26:14 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:26:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:26:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:26:14 INFO - Fetch https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:26:15 INFO - Expected file size: 16356114 08:26:15 INFO - Obtained file size: 16356114 08:26:21 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:26:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:26:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:26:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:26:22 INFO - Expected file size: 16356114 08:26:22 INFO - Obtained file size: 16356114 08:26:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:26:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:26:28 INFO - Fetch https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:26:30 INFO - Expected file size: 14403485 08:26:30 INFO - Obtained file size: 14403485 08:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:30 INFO - trying https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:26:30 INFO - Downloading https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:26:32 INFO - Downloaded 73827358 bytes. 08:26:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:26:32 INFO - mkdir: /builds/slave/test/properties 08:26:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:32 INFO - Contents: 08:26:32 INFO - build_url:https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:26:33 INFO - Running post-action listener: _resource_record_post_action 08:26:33 INFO - Running post-action listener: set_extra_try_arguments 08:26:33 INFO - [mozharness: 2017-02-06 16:26:33.410330Z] Finished download-and-extract step (success) 08:26:33 INFO - [mozharness: 2017-02-06 16:26:33.410504Z] Running populate-webroot step. 08:26:33 INFO - Running pre-action listener: _resource_record_pre_action 08:26:33 INFO - Running main action method: populate_webroot 08:26:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:33 INFO - '--tppagecycles', 08:26:33 INFO - '7'], 08:26:33 INFO - 'tests': ['tsvgm']}}, 08:26:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['damp', 'tps']}, 08:26:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'tests': ['damp', 'tps']}, 08:26:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['dromaeo_dom']}, 08:26:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['basic_compositor_video']}, 08:26:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:26:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['a11yr', 08:26:33 INFO - 'ts_paint', 08:26:33 INFO - 'tpaint', 08:26:33 INFO - 'sessionrestore', 08:26:33 INFO - 'sessionrestore_no_auto_restore', 08:26:33 INFO - 'tabpaint']}, 08:26:33 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:33 INFO - 'ts_paint', 08:26:33 INFO - 'tpaint', 08:26:33 INFO - 'sessionrestore', 08:26:33 INFO - 'sessionrestore_no_auto_restore', 08:26:33 INFO - 'tabpaint']}, 08:26:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:33 INFO - 'ts_paint', 08:26:33 INFO - 'tpaint', 08:26:33 INFO - 'sessionrestore', 08:26:33 INFO - 'sessionrestore_no_auto_restore', 08:26:33 INFO - 'tabpaint']}, 08:26:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:33 INFO - 'ts_paint', 08:26:33 INFO - 'tpaint', 08:26:33 INFO - 'sessionrestore', 08:26:33 INFO - 'sessionrestore_no_auto_restore', 08:26:33 INFO - 'tabpaint']}, 08:26:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['a11yr', 08:26:33 INFO - 'ts_paint', 08:26:33 INFO - 'tpaint', 08:26:33 INFO - 'sessionrestore', 08:26:33 INFO - 'sessionrestore_no_auto_restore', 08:26:33 INFO - 'tabpaint']}, 08:26:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['a11yr', 08:26:33 INFO - 'ts_paint', 08:26:33 INFO - 'tpaint', 08:26:33 INFO - 'sessionrestore', 08:26:33 INFO - 'sessionrestore_no_auto_restore', 08:26:33 INFO - 'tabpaint']}, 08:26:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['tsvgx', 08:26:33 INFO - 'tsvgr_opacity', 08:26:33 INFO - 'tart', 08:26:33 INFO - 'tscrollx', 08:26:33 INFO - 'cart', 08:26:33 INFO - 'tsvg_static']}, 08:26:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:33 INFO - 'tsvgr_opacity', 08:26:33 INFO - 'tart', 08:26:33 INFO - 'tscrollx', 08:26:33 INFO - 'cart', 08:26:33 INFO - 'tsvg_static']}, 08:26:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'talos_options': ['--disable-e10s'], 08:26:33 INFO - 'tests': ['tp5o']}, 08:26:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:26:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'talos_options': ['--disable-e10s', 08:26:33 INFO - '--xperf_path', 08:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:33 INFO - 'tests': ['tp5n']}, 08:26:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:26:33 INFO - 'talos_options': ['--xperf_path', 08:26:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:33 INFO - 'tests': ['tp5n']}}, 08:26:33 INFO - 'talos.zip': {'path': '', 08:26:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:33 INFO - Running post-action listener: _resource_record_post_action 08:26:33 INFO - [mozharness: 2017-02-06 16:26:33.428812Z] Finished populate-webroot step (success) 08:26:33 INFO - [mozharness: 2017-02-06 16:26:33.428944Z] Running create-virtualenv step. 08:26:33 INFO - Running pre-action listener: _resource_record_pre_action 08:26:33 INFO - Running main action method: create_virtualenv 08:26:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:26:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:33 INFO - Using real prefix '/tools/python27' 08:26:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:37 INFO - Installing pip.................done. 08:26:37 INFO - Return code: 0 08:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:26:37 INFO - Reading from file tmpfile_stdout 08:26:37 INFO - Output received: 08:26:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:26:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:37 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:37 INFO - 'HOME': '/Users/cltbld', 08:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:37 INFO - 'LOGNAME': 'cltbld', 08:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:37 INFO - 'MOZ_NO_REMOTE': '1', 08:26:37 INFO - 'NO_EM_RESTART': '1', 08:26:37 INFO - 'PAGER': '/bin/cat', 08:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:37 INFO - 'PWD': '/builds/slave/test', 08:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:37 INFO - 'SHELL': '/bin/bash', 08:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:37 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:37 INFO - 'USER': 'cltbld', 08:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:37 INFO - 'XPC_FLAGS': '0x0', 08:26:37 INFO - 'XPC_SERVICE_NAME': '0', 08:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:26:37 INFO - Cleaning up... 08:26:37 INFO - Return code: 0 08:26:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:37 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:37 INFO - 'HOME': '/Users/cltbld', 08:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:37 INFO - 'LOGNAME': 'cltbld', 08:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:37 INFO - 'MOZ_NO_REMOTE': '1', 08:26:37 INFO - 'NO_EM_RESTART': '1', 08:26:37 INFO - 'PAGER': '/bin/cat', 08:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:37 INFO - 'PWD': '/builds/slave/test', 08:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:37 INFO - 'SHELL': '/bin/bash', 08:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:37 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:37 INFO - 'USER': 'cltbld', 08:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:37 INFO - 'XPC_FLAGS': '0x0', 08:26:37 INFO - 'XPC_SERVICE_NAME': '0', 08:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:37 INFO - Downloading/unpacking psutil>=3.1.1 08:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:41 INFO - Installing collected packages: psutil 08:26:41 INFO - Running setup.py install for psutil 08:26:41 INFO - building 'psutil._psutil_osx' extension 08:26:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:26: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:26: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:26:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:26:42 INFO - building 'psutil._psutil_posix' extension 08:26:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:26:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:26:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:26:42 INFO - ^ 08:26:42 INFO - 1 warning generated. 08:26:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:42 INFO - Successfully installed psutil 08:26:42 INFO - Cleaning up... 08:26:42 INFO - Return code: 0 08:26:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:42 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:42 INFO - 'HOME': '/Users/cltbld', 08:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:42 INFO - 'LOGNAME': 'cltbld', 08:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:42 INFO - 'MOZ_NO_REMOTE': '1', 08:26:42 INFO - 'NO_EM_RESTART': '1', 08:26:42 INFO - 'PAGER': '/bin/cat', 08:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:42 INFO - 'PWD': '/builds/slave/test', 08:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:42 INFO - 'SHELL': '/bin/bash', 08:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:42 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:42 INFO - 'USER': 'cltbld', 08:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:42 INFO - 'XPC_FLAGS': '0x0', 08:26:42 INFO - 'XPC_SERVICE_NAME': '0', 08:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:45 INFO - Installing collected packages: mozsystemmonitor 08:26:45 INFO - Running setup.py install for mozsystemmonitor 08:26:45 INFO - Successfully installed mozsystemmonitor 08:26:45 INFO - Cleaning up... 08:26:45 INFO - Return code: 0 08:26:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:45 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:45 INFO - 'HOME': '/Users/cltbld', 08:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:45 INFO - 'LOGNAME': 'cltbld', 08:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:45 INFO - 'MOZ_NO_REMOTE': '1', 08:26:45 INFO - 'NO_EM_RESTART': '1', 08:26:45 INFO - 'PAGER': '/bin/cat', 08:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:45 INFO - 'PWD': '/builds/slave/test', 08:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:45 INFO - 'SHELL': '/bin/bash', 08:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:45 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:45 INFO - 'USER': 'cltbld', 08:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:45 INFO - 'XPC_FLAGS': '0x0', 08:26:45 INFO - 'XPC_SERVICE_NAME': '0', 08:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:46 INFO - Downloading/unpacking jsonschema==2.5.1 08:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:49 INFO - warning: no files found matching '*.txt' 08:26:49 INFO - no previously-included directories found matching 'build' 08:26:49 INFO - no previously-included directories found matching 'dist' 08:26:49 INFO - no previously-included directories found matching '.git*' 08:26:49 INFO - Installing collected packages: jsonschema, functools32 08:26:49 INFO - Running setup.py install for functools32 08:26:49 INFO - warning: no files found matching '*.txt' 08:26:49 INFO - no previously-included directories found matching 'build' 08:26:49 INFO - no previously-included directories found matching 'dist' 08:26:49 INFO - no previously-included directories found matching '.git*' 08:26:49 INFO - Successfully installed jsonschema functools32 08:26:49 INFO - Cleaning up... 08:26:49 INFO - Return code: 0 08:26:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:49 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:49 INFO - 'HOME': '/Users/cltbld', 08:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:49 INFO - 'LOGNAME': 'cltbld', 08:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:49 INFO - 'MOZ_NO_REMOTE': '1', 08:26:49 INFO - 'NO_EM_RESTART': '1', 08:26:49 INFO - 'PAGER': '/bin/cat', 08:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:49 INFO - 'PWD': '/builds/slave/test', 08:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:49 INFO - 'SHELL': '/bin/bash', 08:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:49 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:49 INFO - 'USER': 'cltbld', 08:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:49 INFO - 'XPC_FLAGS': '0x0', 08:26:49 INFO - 'XPC_SERVICE_NAME': '0', 08:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:26:49 INFO - Cleaning up... 08:26:49 INFO - Return code: 0 08:26:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:49 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:49 INFO - 'HOME': '/Users/cltbld', 08:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:49 INFO - 'LOGNAME': 'cltbld', 08:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:49 INFO - 'MOZ_NO_REMOTE': '1', 08:26:49 INFO - 'NO_EM_RESTART': '1', 08:26:49 INFO - 'PAGER': '/bin/cat', 08:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:49 INFO - 'PWD': '/builds/slave/test', 08:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:49 INFO - 'SHELL': '/bin/bash', 08:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:49 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:49 INFO - 'USER': 'cltbld', 08:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:49 INFO - 'XPC_FLAGS': '0x0', 08:26:49 INFO - 'XPC_SERVICE_NAME': '0', 08:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:53 INFO - Downloading docopt-0.6.1.tar.gz 08:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:53 INFO - Running setup.py install for blobuploader 08:26:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:54 INFO - Running setup.py install for requests 08:26:54 INFO - Running setup.py install for docopt 08:26:54 INFO - Successfully installed blobuploader requests docopt 08:26:54 INFO - Cleaning up... 08:26:54 INFO - Return code: 0 08:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:54 INFO - 'HOME': '/Users/cltbld', 08:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:54 INFO - 'LOGNAME': 'cltbld', 08:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:54 INFO - 'MOZ_NO_REMOTE': '1', 08:26:54 INFO - 'NO_EM_RESTART': '1', 08:26:54 INFO - 'PAGER': '/bin/cat', 08:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:54 INFO - 'PWD': '/builds/slave/test', 08:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:54 INFO - 'SHELL': '/bin/bash', 08:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:54 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:54 INFO - 'USER': 'cltbld', 08:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:54 INFO - 'XPC_FLAGS': '0x0', 08:26:54 INFO - 'XPC_SERVICE_NAME': '0', 08:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Wgmc3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-AAdKln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-1LLqQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-q3h4Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-tp9zH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-brwPIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-QQQgP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-6q8rET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-jq1L1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:55 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZVcBbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-CRQquq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-egDnGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-PRJZKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-iUDK5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ilutma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0j0CKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:56 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wzDoT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:56 INFO - Running setup.py install for manifestparser 08:26:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:56 INFO - Running setup.py install for mozcrash 08:26:57 INFO - Running setup.py install for mozdebug 08:26:57 INFO - Running setup.py install for mozdevice 08:26:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Running setup.py install for mozfile 08:26:57 INFO - Running setup.py install for mozhttpd 08:26:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Running setup.py install for mozinfo 08:26:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Running setup.py install for mozInstall 08:26:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:57 INFO - Running setup.py install for mozleak 08:26:58 INFO - Running setup.py install for mozlog 08:26:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for moznetwork 08:26:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozprocess 08:26:58 INFO - Running setup.py install for mozprofile 08:26:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozrunner 08:26:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:58 INFO - Running setup.py install for mozscreenshot 08:26:59 INFO - Running setup.py install for moztest 08:26:59 INFO - Running setup.py install for mozversion 08:26:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:59 INFO - Cleaning up... 08:26:59 INFO - Return code: 0 08:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:59 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:59 INFO - 'HOME': '/Users/cltbld', 08:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:59 INFO - 'LOGNAME': 'cltbld', 08:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:59 INFO - 'MOZ_NO_REMOTE': '1', 08:26:59 INFO - 'NO_EM_RESTART': '1', 08:26:59 INFO - 'PAGER': '/bin/cat', 08:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:59 INFO - 'PWD': '/builds/slave/test', 08:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:59 INFO - 'SHELL': '/bin/bash', 08:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:26:59 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:59 INFO - 'USER': 'cltbld', 08:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:59 INFO - 'XPC_FLAGS': '0x0', 08:26:59 INFO - 'XPC_SERVICE_NAME': '0', 08:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:59 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-n0sJPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:59 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Hbvljs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:59 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_BhdLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:59 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-v8ap2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-FY_1ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27: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)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-vadw3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Kh7Yv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Rvz6Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-BX9r83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-3iQBgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-i1mphm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-zyIMAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:00 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-lfAs4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27: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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:01 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-amr2v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:01 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-2BylPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27: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)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:01 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-SooBAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:01 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-xLiOkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:27:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:04 INFO - Downloading blessings-1.6.tar.gz 08:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:04 INFO - Installing collected packages: blessings 08:27:04 INFO - Running setup.py install for blessings 08:27:04 INFO - Successfully installed blessings 08:27:04 INFO - Cleaning up... 08:27:04 INFO - Return code: 0 08:27:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:04 INFO - Reading from file tmpfile_stdout 08:27:04 INFO - Current package versions: 08:27:04 INFO - blessings == 1.6 08:27:04 INFO - blobuploader == 1.2.4 08:27:04 INFO - docopt == 0.6.1 08:27:04 INFO - functools32 == 3.2.3-2 08:27:04 INFO - jsonschema == 2.5.1 08:27:04 INFO - manifestparser == 1.1 08:27:04 INFO - mozInstall == 1.12 08:27:04 INFO - mozcrash == 1.0 08:27:04 INFO - mozdebug == 0.1 08:27:04 INFO - mozdevice == 0.49 08:27:04 INFO - mozfile == 1.2 08:27:04 INFO - mozhttpd == 0.7 08:27:04 INFO - mozinfo == 0.9 08:27:04 INFO - mozleak == 0.1 08:27:04 INFO - mozlog == 3.4 08:27:04 INFO - moznetwork == 0.27 08:27:04 INFO - mozprocess == 0.24 08:27:04 INFO - mozprofile == 0.28 08:27:04 INFO - mozrunner == 6.13 08:27:04 INFO - mozscreenshot == 0.1 08:27:04 INFO - mozsystemmonitor == 0.3 08:27:04 INFO - moztest == 0.8 08:27:04 INFO - mozversion == 1.4 08:27:04 INFO - psutil == 3.1.1 08:27:04 INFO - requests == 1.2.3 08:27:04 INFO - wsgiref == 0.1.2 08:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:04 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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:04 INFO - 'HOME': '/Users/cltbld', 08:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:04 INFO - 'LOGNAME': 'cltbld', 08:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:04 INFO - 'MOZ_NO_REMOTE': '1', 08:27:04 INFO - 'NO_EM_RESTART': '1', 08:27:04 INFO - 'PAGER': '/bin/cat', 08:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:04 INFO - 'PWD': '/builds/slave/test', 08:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:04 INFO - 'SHELL': '/bin/bash', 08:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:27:04 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:04 INFO - 'USER': 'cltbld', 08:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:04 INFO - 'XPC_FLAGS': '0x0', 08:27:04 INFO - 'XPC_SERVICE_NAME': '0', 08:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27: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)) 08:27:05 INFO - Cleaning up... 08:27:05 INFO - Return code: 0 08:27:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27: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')]} 08:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27: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')]} 08:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27: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 0x1014e9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014ec768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f969bc78470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, '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.XERcr2VNkF/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.65wZrS5GCs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:27: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 08:27: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 08:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:05 INFO - 'HOME': '/Users/cltbld', 08:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:05 INFO - 'LOGNAME': 'cltbld', 08:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:05 INFO - 'MOZ_NO_REMOTE': '1', 08:27:05 INFO - 'NO_EM_RESTART': '1', 08:27:05 INFO - 'PAGER': '/bin/cat', 08:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:05 INFO - 'PWD': '/builds/slave/test', 08:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:05 INFO - 'SHELL': '/bin/bash', 08:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:27:05 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:05 INFO - 'USER': 'cltbld', 08:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:05 INFO - 'XPC_FLAGS': '0x0', 08:27:05 INFO - 'XPC_SERVICE_NAME': '0', 08:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:05 INFO - Cleaning up... 08:27:05 INFO - Return code: 0 08:27:05 INFO - Running post-action listener: _resource_record_post_action 08:27:05 INFO - Running post-action listener: _start_resource_monitoring 08:27:05 INFO - Starting resource monitoring. 08:27:05 INFO - [mozharness: 2017-02-06 16:27:05.415094Z] Finished create-virtualenv step (success) 08:27:05 INFO - [mozharness: 2017-02-06 16:27:05.416041Z] Running install step. 08:27:05 INFO - Running pre-action listener: _resource_record_pre_action 08:27:05 INFO - Running main action method: install 08:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:05 INFO - Reading from file tmpfile_stdout 08:27:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:05 INFO - Reading from file tmpfile_stdout 08:27:05 INFO - Output received: 08:27:05 INFO - Usage: mozinstall [options] installer 08:27:05 INFO - Options: 08:27:05 INFO - -h, --help show this help message and exit 08:27:05 INFO - -d DEST, --destination=DEST 08:27:05 INFO - Directory to install application into. [default: 08:27:05 INFO - "/builds/slave/test"] 08:27:05 INFO - --app=APP Application being installed. [default: firefox] 08:27:05 INFO - mkdir: /builds/slave/test/build/application 08:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:27:25 INFO - Reading from file tmpfile_stdout 08:27:25 INFO - Output received: 08:27:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:27:25 INFO - Running post-action listener: _resource_record_post_action 08:27:25 INFO - [mozharness: 2017-02-06 16:27:25.737640Z] Finished install step (success) 08:27:25 INFO - [mozharness: 2017-02-06 16:27:25.737785Z] Running run-tests step. 08:27:25 INFO - Running pre-action listener: _resource_record_pre_action 08:27:25 INFO - Running main action method: run_tests 08:27:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:25 INFO - 2017-02-06 08:27:25.752 screenresolution[1906:15417] starting screenresolution argv=screenresolution get 08:27:25 INFO - 2017-02-06 08:27:25.754 screenresolution[1906:15417] Display 0: 1600x1200x32@60 08:27:25 INFO - 2017-02-06 08:27:25.760 screenresolution[1907:15420] starting screenresolution argv=screenresolution list 08:27:25 INFO - Available Modes on Display 0 08:27:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:25 INFO - Intel Iris: 08:27:25 INFO - Chipset Model: Intel Iris 08:27:25 INFO - Type: GPU 08:27:25 INFO - Bus: Built-In 08:27:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:25 INFO - Vendor: Intel (0x8086) 08:27:25 INFO - Device ID: 0x0a2e 08:27:25 INFO - Revision ID: 0x0009 08:27:25 INFO - Displays: 08:27:25 INFO - Display: 08:27:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:25 INFO - Display Serial Number: 1600x1200 60 08:27:25 INFO - Main Display: Yes 08:27:25 INFO - Mirror: Off 08:27:25 INFO - Online: Yes 08:27:25 INFO - Rotation: Supported 08:27:25 INFO - Return code: 0 08:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:26 INFO - Python 2.7.3 08:27:26 INFO - Return code: 0 08:27:26 INFO - grabbing minidump binary from tooltool 08:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:26 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 0x1012c7d30>, '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 0x1011eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012bcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:27:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:27:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:27:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:26 INFO - Return code: 0 08:27:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:27:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:27:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XERcr2VNkF/Render', 08:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:26 INFO - 'HOME': '/Users/cltbld', 08:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:26 INFO - 'LOGNAME': 'cltbld', 08:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:26 INFO - 'MOZ_NO_REMOTE': '1', 08:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:26 INFO - 'NO_EM_RESTART': '1', 08:27:26 INFO - 'PAGER': '/bin/cat', 08:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:26 INFO - 'PWD': '/builds/slave/test', 08:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:26 INFO - 'SHELL': '/bin/bash', 08:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.65wZrS5GCs/Listeners', 08:27:26 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 08:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:26 INFO - 'USER': 'cltbld', 08:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:26 INFO - 'XPC_FLAGS': '0x0', 08:27:26 INFO - 'XPC_SERVICE_NAME': '0', 08:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:27:26 INFO - mozversion application_buildid: 20170206070950 08:27:26 INFO - mozversion application_changeset: 4f8f9621e75b23ba8f2546cc081df6981f46b13d 08:27:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:26 INFO - mozversion application_name: Firefox 08:27:26 INFO - mozversion application_remotingname: firefox-dev 08:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:27:26 INFO - mozversion application_vendor: Mozilla 08:27:26 INFO - mozversion application_version: 53.0a2 08:27:26 INFO - mozversion platform_buildid: 20170206070950 08:27:26 INFO - mozversion platform_changeset: 4f8f9621e75b23ba8f2546cc081df6981f46b13d 08:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:27:26 INFO - mozversion platform_version: 53.0a2 08:27:26 INFO - using testdate: 1486398446 08:27:26 INFO - actual date: 1486398446 08:27:26 INFO - starting webserver on 'localhost:51030' 08:27:26 INFO - SUITE-START | Running 2 tests 08:27:26 INFO - TEST-START | dromaeo_css 08:27:26 INFO - operating with platform_type : mac_ 08:27:26 INFO - Initialising browser for dromaeo_css test... 08:27:26 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpzAKEUl/profile http://localhost:51030/getInfo.html) 08:27:28 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 08:27:28 INFO - PROCESS | 1917 | colorDepth:24 08:27:28 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 08:27:28 INFO - PROCESS | 1917 | __metrics 08:27:28 INFO - PROCESS | 1917 | 1486398448804 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:27:28 INFO - PROCESS | 1917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:27:28 INFO - PROCESS | 1917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:29 INFO - TEST-INFO | 1917: exit 0 08:27:29 INFO - Browser initialized. 08:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:29 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpzAKEUl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:41 INFO - PROCESS | 1919 | RSS: Main: 213151744 08:27:41 INFO - PROCESS | 1919 | 08:30:45 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:51030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51030/tests/dromaeo/cssquery-ext.html) 08:30:47 INFO - PROCESS | 1919 | RSS: Main: 361877504 08:30:47 INFO - PROCESS | 1919 | 08:32:31 INFO - PROCESS | 1919 | ************************* 08:32:31 INFO - PROCESS | 1919 | A coding exception was thrown and uncaught in a Task. 08:32:31 INFO - PROCESS | 1919 | 08:32:31 ERROR - PROCESS | 1919 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:32:31 INFO - PROCESS | 1919 | Full stack: 08:32:31 INFO - PROCESS | 1919 | ************************* 08:33:50 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:51030/tests/dromaeo/cssquery-ext.html (next: http://localhost:51030/tests/dromaeo/cssquery-jquery.html) 08:33:50 INFO - PROCESS | 1919 | RSS: Main: 349364224 08:33:50 INFO - PROCESS | 1919 | 08:36:53 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:51030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51030/tests/dromaeo/cssquery-mootools.html) 08:36:53 INFO - PROCESS | 1919 | RSS: Main: 330240000 08:36:53 INFO - PROCESS | 1919 | 08:39:56 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:51030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51030/tests/dromaeo/cssquery-prototype.html) 08:39:56 INFO - PROCESS | 1919 | RSS: Main: 328785920 08:39:56 INFO - PROCESS | 1919 | 08:43:00 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:51030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51030/tests/dromaeo/cssquery-yui.html) 08:43:00 INFO - PROCESS | 1919 | RSS: Main: 321060864 08:43:00 INFO - PROCESS | 1919 | 08:46:03 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:51030/tests/dromaeo/cssquery-yui.html (next: http://localhost:51030/tests/dromaeo/cssquery-dojo.html) 08:46:04 INFO - PROCESS | 1919 | RSS: Main: 477011968 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | __start_tp_report 08:46:04 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 08:46:04 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 08:46:04 INFO - PROCESS | 1919 | |i|pagename|runs| 08:46:04 INFO - PROCESS | 1919 | |0;dojo.html;3370.1069216657584;3381.8478168482416;3395.8981230563077;3403.659634036598;3454.618152738904;5818.301803783546;5876.44173803488;5880.411958804118;5882.558808089394;5887.293524777027;5800.47795698387;5880.970595147019;5900.262467191601;5901.881962360751;5907;5248.5276325130735;5286.418493965661;5295.602829787762;5380.381256155533;5384.138537833947;5231.503007214308;5263.789448422078;5274.103402421598;5376.086065368897;5391.272178255944;5306.602004849632;5347.358317001966;5348.705821179834;5351.678899266057;5354.973225133888;5321.122014867561;5346.572274218053;5367.677939323653;5379.757910894019;5395.568354531628;5245.711485868275;5327.121025030865;5333.2266821310695;5339.385970613391;5374.355077390738;5937.910931336033;5941.2276404067625;5942.851428714317;5984.491318237955;5985.7306421210715;6156.322804491502;6206.596571222856;6257.530685198628;6293.968530157365;6299.559030867841;6205.255369355661;6211.440970312694;6238.688065596702;6281.905771413432;6342.6511541865175;6024.969875150597;6028.246469191351;6031.790240117792;6043.395660433922;6079.787207447718;6416.230052393649;6428.100065990765;6434.131392262078;6451.774187903401;6458.6770661466735;5118.948810511847;6125.490313351988;6132.294786099566;6185.226846644169;6189.81430557084;6289.0880822280515;6291.96854015727;6302.149209856702;6311.2426508819235;6312.684365781693;6223.657698826608;6234.220722409699;6235.345288744707;6264.498840092781;6272.717727702265;6172.9074063889075;6215.440610345;6229.190205273286;6271.843203919847;6272.905906411407;5027.698338099725;5048;5053.938672878663;5077.619178561623;5079.263506791494;4502.16709908668;4505.121501307213;4510.188166130128;4510.977445112819;4539.886502837456;5734.426557344315;5742.712864356766;5965.403459654;5982.952983227918;5987.9101813472835;6215.192025036717;6257.7809776658505;6268.059791031382;6299.212598425197;6300.243970723543;5767.653940763567;5984.7606095756555;6032.698365081728;6045.758169673164;6064.454199122012;5483.945160548344;5535.975844468786;5537.7784888604;5538.113901775697;5538.307711536058;6290.622562646256;6366.299707032223;6367.3314301997625;6379.872402552016;6383.042543618494;6234.657093859882;6285.5600107992;6292.433680968552;6318.368163183645;6323.9683801580695;6488.935110648833;6489.123968264224;6501.08984742127;6502.187226596676;6522.15212022434;6148.846278843064;6204.565680402328;6220.191375121205;6227.50179985591;6234.251889773256;6280.7487700491465;6281.654509002049;6296.244450665949;6305.558610897193;6306.716197771203;4663.766811659471;6175.62946223228;6255.218097737783;6265.937340626535;6267.185265915584;6044.335123136363;6131.938680613137;6138.633639632548;6143.938560614515;6255.593386429868;6052.757889684363;6120.190246383004;6125.296497837281;6134.650895842656;6139.058058263141;6199.845003874939;6238;6241.500679945502;6256.499480041677;6259.530535209787;4864.6594738369395;5932.911006334994;6074.210352654127;6083.969580152071;6131.96934015327 08:46:04 INFO - PROCESS | 1919 | |1;ext.html;450.97068690535133;472.7352682497801;481.8723038394826;505.0958783777039;507.53306957599006;32203.03390898274;40742.388864167064;42235;42397.57602423975;44261.336079958826;42652.57347426525;43123.568764312346;43133.92165195871;43139.56860431395;43295;8398.328133749286;9168.679096231617;9391.718248452557;9399.248060155205;9405.388649737779;8355.331573474137;11095.667129986114;11361.375124368156;11389.031932285765;11527.962483376494;11263.380514071763;11292.266002709797;11309.773804523904;11332.980031797137;11356.545738170464;8382.706605268786;8607.913920860774;11253.212275140744;11312.377819219939;11334.263272887318;10862.185336099825;11162.497687603996;11183.217174797768;11347;11362.602308919231;40611;40992.79503602493;41094.76715698534;41132.588674113475;41169;3925.2738243424774;4009.3184158693093;4061.208064427438;4067.1458993611377;4078.4290199372113;23420.64869026966;29031.564526532118;29239.41521169586;30853.691463085306;31266.843665781755;3225.0969728476066;3246.1722260823576;3262.755293353008;3294.7034766870856;3368.9663103369144;374156;375369;376222;376676.1166194179;377309;62495.375046249865;62817.68591157015;62849;62912;62958;65405.69188616201;65501.67249163723;65592.34407655957;65596.34403655998;65675.67162164254;16207.270672819515;16211.594710132342;16815.831841681673;16852.83147168537;16881.91559042197;11804.586839460577;12115.515379384902;12860.742785144432;13017.349132543335;13100.672483187996;13478.595642130556;13679.452821887013;16646.916765416096;16687.415940442028;16819.831801681827;5625.971870140623;6714.798556043326;6754.628495432798;6786;6848.212455567574;770.3067239484396;874.6020560644891;898.6630013744846;898.8561830107152;900.3157600223877;29460.705392945798;30230.84884575563;30406.54390184149;31011.84494077515;31034.0689779307;950.5342382232657;951.5765484359532;1128.537299707116;1131.281636161027;1139.8233273842568;14302.642433939027;14716.705665886622;14781.704365912621;14992.95049346557;15078.924605376902;428068;430221;430706;430975;431381;55413.44586554083;55664;55680;55793.44206557883;55843;1421.4882642248783;1446.681730019415;1474.6387135151956;1475.4762059468949;1480.4004378226834;27328.180154595393;28095.297617559725;28644.283892902844;28700.629194212743;28978;46295.76852115718;46605.06789864116;46607.30089048735;46609.766951165024;46715.766421167675;353389.4661053459;354731;358760;358937;359010;36075.09812254609;36318;36611.63388366082;36768;36769.816150919076;42543.78728106464;42853.35719964141;43610.781946090065;43642.56357436512;43919;35340.76307329231;36263.27473450569;36277.63722362848;37170;37533.81233093926;35861.82069089638;35920.820395897856;36481.452778207815;36702.89891303265;36913.815430922674;35709.75015874432;35863.48386713129;35876.28247435089;35997.82001089978;36277.455838162976;30571.388572228876;32745.508817368234;32837.17907052247;32842.343153137284;32881.835590821895;23792.881035595405;23900.163494277618;24265.393365165306;24383.878080609484;24437.38906527351 08:46:04 INFO - PROCESS | 1919 | |2;jquery.html;369.3665363900909;387.8351700527275;389.6045513803489;399.6682753314749;420.1848414076691;15344.156071416082;15435.922820385897;18585.907070464647;20648.48378790531;20854.374368768924;21407.67888481674;21537.892310538464;21705.891470542625;21888.781112188874;21986.670199946973;5589.580781441398;5678.290213723285;5744.368119506851;5835.649861008332;5918.763249470016;5984.8503787405225;6018.6990650467305;6028.246469191351;6029.939700603004;6030.63816171029;3903.8243279052367;4032.0726232966435;4059.289624315748;4080.367543030835;6550.508711846607;6585.703643336037;6607.041978913078;6607.372299631527;6608.107905432777;6625.569337993015;5136.255242989746;5353.625246232766;5422.864428389283;5464.6994415307145;5472.315960504937;13155.539556115586;13362.198268103848;16879.91560042192;25508.74491255082;25976.87011564949;2563.205406324027;2571.4985577812336;2641.8811153497945;2642.379040925381;2645.2725500487327;8922.10778922109;9605.327627066108;9753.756156096084;9866.210703143732;10281.383117012929;1740.2864825421643;1789.0875653416722;1791.5342011077084;1806.765120534322;1809.5295223242051;105604;112741;114180;114328.42835785852;114597;9924.50377481123;11336.263142895685;11585.246958947642;11736.647900562997;11800.940995295141;15433.922830385776;15479.071255724693;15481.5355539334;15481.767773483407;15513.991590546579;8718.17177368149;8839.602217900081;8852.513111778786;8865.734027979172;8949.955250223837;8764.693235736719;8795.648174072965;8830.823383532423;8905;8941.46351218929;3819.789911554891;4647.86056418308;4650.37219975299;4668.8132474701315;4731.881702957454;1690.0451245046509;1955.1788248935482;2004.3285499357587;2008.5480766827638;2013.2752209204675;1007.9970429422625;1022.5858527296457;1025.9025392587691;1030.6804890483975;1070;16960.406385776438;21620.567588648453;21700.91495425254;21720.89139554292;21782.673259901116;1017.4251547875426;1047.1099565369375;1050.422267752733;1061.2093989977516;1067.5729708116814;10344.793104137874;11186.664400068012;11214.775704485864;11241.213115081866;11255.943720281346;737817;760328;760399;773621;781486;108414;114172.783738001;130379;146382;162570;794.4200733464488;964.1804466203811;975.2393133355994;977.8093271812071;978.0512902484578;16225.59436014109;18932.905335473235;19223.90388048051;19597.31409400664;19699.606007880047;60161.69919150551;61535.6923215381;62538.68730656317;64156.35843641504;65220.412877292205;93146.53426732823;94184.05815942027;94448.52775736077;94954;96586;8116.513009219229;8153.959230203811;8436.53599052058;8565.785855353666;8576.31389488827;10703.036726694323;10777;12199.421691079075;12635;13006.934965325112;11019.449027548751;11070.501827417624;11105.00054995022;11223.887761122285;11532.94233528827;9124.49815260167;10915.563377464812;10937.632795900512;11058.889411105785;11161.832572511257;10599.258051936291;10608.363498190134;10707.678769636923;10894.182936279652;10955.890441095487;8153.470024448629;8208.343332533503;8418.747437576883;8431.28334091609;8443.40896137289;9416.576254068721;10997.505112269808;11144.33134011962;11314.886851131712;11460.885391145981 08:46:04 INFO - PROCESS | 1919 | |3;mootools.html;1268.6257554021563;1453.6220582648511;1466.7139907717992;1475.4762059468892;1478.91126532408;7964.323032542234;8408.705695300665;8414.326853851693;8415.116412776655;8435.40952133351;7298.160711518177;7595.924040759591;7596;7945.245201705843;8124.146964568724;1997.8901160436171;2314.3866875278063;2340.7776261255153;2358.929232123039;2360.799332056777;2282.3267136194863;2367.562001029815;2376.275236053003;2379.3694670912137;2383.4994651123197;2061.268249771332;2145.1633862793524;2267.3764714703507;2344.0623750499767;2345.3901985483726;2345.9677741793726;2351.423901144222;2372.5966585680476;2373.964390534143;2378.1795280628157;2352.564775516535;2361.9173328933575;2385.630227314769;2394.8084153267696;2396.3290278721984;8319.251267385964;8409.747707568782;8431.873521897176;8438.57807109642;8453.450525715809;5031.069252188357;5178.533931946105;5187.118189907725;5200.8179713710215;5203.453637368059;3188.7608429367892;3296.950545741816;3365.730741540671;3415.2315728960784;3418.1454636340914;1115.5370521233679;1130.7399298161386;1150.6030419505257;1172.5192671004932;1173.87606558674;10732.980366865213;10856.402897840615;10857.67426977192;10869;10879.020888120029;4479.7536135512855;4669.112868554964;4758.976205118952;4763.499832517605;4773.498782627844;9550.092741189575;9568.665096721581;9574.617015319449;9575.329726919188;9594.616215351307;5244.842654720364;5254.106801843695;5254.868628284247;5261.868453288698;5275.60432967529;4603.654725895504;4694.108119457293;4729.95270047302;4790.353302304214;4856.028794241166;3841.9423708644395;3901.1612503311926;3905.511811023622;3947.6052394760295;3988.082740969593;1165.2018367418345;1257.9559715409916;1265.2092442223611;1266.7593157300269;1288.845338559379;765.9812449442228;780.4185881518192;806.7620052084649;806.9233422824823;811.1807074854439;5657.4908258256955;5739.339975902742;5855;5894.764209431661;5923.49650279731;999.4503023337136;999.7600575861741;1000.4147573669485;1003.6386900715737;1040.8074506216374;2741.7943654226015;3864.613538646113;3940.625640564142;3953.5058117735284;3987.80060996949;9808.16630586408;10174.643887464052;10182.439965801805;10194.980501949894;10210.234232432596;10124.746881328027;10125.038121378457;10125.443100629389;10128.189744820544;10135.594576216869;7407.222241664547;7764.961175194087;7824.92175078242;8053.07389650186;8058.959705201437;5695.572832037531;5756.3380211276235;5875.588708790515;5940.198073260228;5948.13752005948;8724.138447632738;9055.637774488947;9090.772730681785;9316.20812230968;9427.292953028413;9375.718728438158;9394.812103758024;9440.291978101806;9440.716778496657;9513.238940884574;7280.672369743268;7322.340989310987;7418.406527477897;7421.703131874665;7426.108866936002;7845.13703492604;7858.174891636296;7951.721689740832;7959.204079591995;7965.362770978424;6396;6940.722371105099;7092.574445533284;7160.785176444715;7281.381082608038;7040.295970402919;7098.893516597152;7143.499955003308;7149.177844547944;7218.675159617725;5489.505944465017;6403.455706265019;6419.711112999833;6428.8071357859335;6476.093346931528;4753.952460475351;4816.084943860656;4834.830780922651;4861.465238823655;4986.551210391082;4970.900581988412;5056.443791182894;5140.691558506502;5158.742062896765;5252.054630166606 08:46:04 INFO - PROCESS | 1919 | |4;prototype.html;350.57930483419887;357.42097801561465;358.652107455768;358.8331425886962;360.5871277387391;4398.868033958983;5239.52844244018;5270.446603106671;5283.313169287992;5363.383210930744;4238.936415953755;4674.247157316006;4943;5248.737563121847;5271.840195157069;3200.9039728808175;3939.1924655445637;4020.9746514638728;4114.2308807212885;4189.874303770892;3640.7633503822167;3974.469105220037;4128.855490057848;4189.560096189902;4241.533431322552;3382.2897191589673;3761.736678432511;3879.573246942834;4076.5719599442077;4136.482939632546;3862.4206369044587;3950.822213000422;4114.897127571805;4155.589757940403;4232.936505952413;3076.507758758588;3239.8455027406744;3697.890632810146;3710.2023065040876;3712.6658600726064;4128.646671397305;4728;4926.334944782444;5173.3533308336455;5232.581393488512;4045.6358927696647;4200.2149086638365;4562.51718191589;4821.758912054418;4848.660593758438;4616.699914505546;5515.573147814948;5526.723663816793;5559.722013899329;5606.243157173811;3831.578526362098;3844.1350696093436;3867.4943690600417;3871.825767840454;3876.0425984877456;5366.946330536644;5465.7913406677035;5839.883202335972;5907.084401917709;5914.053751399755;3425.3491836550975;3472.808995505221;3565.857365705395;3924.529056513237;3940.310445671996;3581;3772.754770939935;3933.996830808183;3957.7229593928723;3995.20095980805;4591.816327346869;4598.517155698671;4631.652626053059;4635.791389387486;4657.231556793091;5031.396232452129;5453.727313634303;5511.283533140666;5616.354119276336;5630.95827271956;1105.7449794483318;1160.3502038858267;1205.3852535207106;1263.0716423428773;1265.5823578219165;731.8426538294292;760.62729262662;812.4962523235632;865.3380164174412;875.2254254984384;4715.7877895494785;4735.608517698609;5048.601914090777;5055.090083784954;5222.321098257202;4625.676202665848;5682.488576028178;5714.228579141763;5720.2849643794525;5744.569157313218;4326.507354962596;4584.020386748573;4843.733594652328;5158.819441319536;5210.452902445189;2740.671119465677;2745.5881617757095;2812.6343575335077;2885.653721553427;2901.1876674531163;4794.640401969867;5593.244911936918;5702.800401985911;5773.826785196451;5803.5357171426185;4843.806247750121;4932.358793356912;4999.750012499433;5137.508308470389;5612.737134144785;4891.51084891508;5017.799288028438;5131.897362052738;5194.584433245332;5366.2487251784005;4968.726894870337;5151.793928242828;5208.270842082035;5242.370915490165;5453.682185071408;4540.322338905497;4943.8516844494725;5445.401005889428;5460.535854452416;5488.240555219687;4841.562490631691;5621.301775148034;5667.85830354228;5710.8572285691525;5732.512736417451;3217.790843595159;3265.7877237979455;3587.9282414352087;3596.460530920383;3613.6928361089604;4564.748938808265;5022.748862556785;5362.758675859518;5384.788422604883;5469.2616496772425;4901;4991.951690144965;5093.821716240062;5202.60980426462;5310;4939.901201975868;5131.435542090442;5206.318745845968;5207.3751149862255;5277.859673494265;4258.169656916872;4561.475430325422;5097.337346144977;5545.722713864371;5553.250311207935;5373.764034272217;5381.3004309441085;5565.276514053147;5580.665160090408;5677.545796336366;5509.614326997072;5517.917231241454;5552.916706249491;5577.653407955195;5585.301837270341 08:46:04 INFO - PROCESS | 1919 | |5;yui.html;694.4201591670954;712.9536580122289;731.3673672273482;778.1518145221711;810.2667086286908;14436;15012.174330411837;15025.17361545116;15027.924860375682;15055.397784088651;14426.42294308229;14426.783598246035;14446.783298250535;14453.92773036136;14569.490067847628;671.7648822911991;698.5319835710086;699.7096205074888;834.9582520873962;850.090403268503;854.0989256334565;860.423516244118;877.0221203358274;877.1579283887476;879.1077056787366;916.0701887584107;916.3493919317293;916.9358144929857;917.499962520428;918.5728636184173;705.1326867952447;733.435254853765;909.9681511147144;911.2345629671108;912.238281035333;656.668382466856;681.6591704147926;686.5571706249441;687.3058211206667;688.9242183359827;15031.022983506036;15379.384824607003;15397;15420.306086226146;15462.381504739797;13111.147775394664;14110.647233819236;14111.78832317516;14150.787738183935;14177;12493.18794278369;12574;12802.295873726942;12857.614271571867;12961.611151665371;3978.0054986253435;4345.760983145926;4415.580519850609;4429.955700442986;4438.866833994985;85652;104441;105330.47334763354;109452.4527377358;109570.45214773875;10358.326708763907;10447.94776026115;10680.465976701134;11261.155413344031;11449.59926402572;21451.892740536197;21624.02691878869;21666.89166554157;21844.890775546337;21970.780292196872;7564.18432878987;7603.163651998276;7663.157052724196;7696.230376962371;7751;4271.700980931305;4278.700490965664;4281.550437204111;4319.460067491564;4346.282863327516;3467.497212904115;3503.404421248394;3538.2039041216035;3561.5904171020147;3572.5355703758346;646.6281887914467;646.7574659502686;653.8201994451564;656.7569999100364;662.2582707367683;637.4868231073938;639.1435476461564;646.1664452855857;648.3905129178557;648.5719425179453;9523.619055237852;9999.850032243103;10025.298229124037;10037;10056.69829905104;620.8385819686823;623.6850390552833;641.9390157934989;653.7777155767062;688.4148473797233;4656.254999200111;4674.766261686902;4722.315264286659;4744.691595046311;4768.61851051915;106139.93860061455;107584;107806.92193077969;108489.45755271331;108934;55042.17436738372;64341;68989.65505172542;75517;85326;74390.62804685942;87056.564717176;87791.12208877958;89816.5509172463;90824;8727.56362181901;10262.560585186253;11133.332000080021;11357.829632555684;11447.427628618703;48591.757041215984;53713;53808.73095634653;55045.62385940384;55935.16097258463;70054.64972675104;70444;70561;70916.29083709097;73763.63118184375;13431.865681343452;14257.857421425653;14319.713605728035;14431.42274309016;14490.565283041526;10716.410597416905;14471.27643617794;15793.763093553376;16033.919830400773;16115;11413.372264525531;14307;14403.711925761636;14406.495772647908;14774.96575239723;12962.611121666365;13392.598222053353;14136.717265654836;14431.639209019439;14437.711245774815;13142.342882855628;13819.239941803296;13833;13948.721025579229;14121.646958826112;10548.736281593021;10869.836952445561;11048.502817373077;11263.745811095941;11647.534098635959;8525.317974562144;9712.417254964725;10428.705684749646;11528.365939873387;11732.12009099304 08:46:04 INFO - PROCESS | 1919 | __end_tp_report 08:46:04 INFO - PROCESS | 1919 | __start_cc_report 08:46:04 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,1548 08:46:04 INFO - PROCESS | 1919 | __end_cc_report 08:46:04 INFO - PROCESS | 1919 | __startTimestamp1486399564093__endTimestamp 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | ------- Summary: start ------- 08:46:04 INFO - PROCESS | 1919 | Number of tests: 6 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | [#0] dojo.html Cycles:165 Average:5835.97 Median:6083.97 stddev:645.30 (10.6%) stddev-sans-first:617.61 08:46:04 INFO - PROCESS | 1919 | Values: 3370.1 3381.8 3395.9 3403.7 3454.6 5818.3 5876.4 5880.4 5882.6 5887.3 5800.5 5881.0 5900.3 5901.9 5907.0 5248.5 5286.4 5295.6 5380.4 5384.1 5231.5 5263.8 5274.1 5376.1 5391.3 5306.6 5347.4 5348.7 5351.7 5355.0 5321.1 5346.6 5367.7 5379.8 5395.6 5245.7 5327.1 5333.2 5339.4 5374.4 5937.9 5941.2 5942.9 5984.5 5985.7 6156.3 6206.6 6257.5 6294.0 6299.6 6205.3 6211.4 6238.7 6281.9 6342.7 6025.0 6028.2 6031.8 6043.4 6079.8 6416.2 6428.1 6434.1 6451.8 6458.7 5118.9 6125.5 6132.3 6185.2 6189.8 6289.1 6292.0 6302.1 6311.2 6312.7 6223.7 6234.2 6235.3 6264.5 6272.7 6172.9 6215.4 6229.2 6271.8 6272.9 5027.7 5048.0 5053.9 5077.6 5079.3 4502.2 4505.1 4510.2 4511.0 4539.9 5734.4 5742.7 5965.4 5983.0 5987.9 6215.2 6257.8 6268.1 6299.2 6300.2 5767.7 5984.8 6032.7 6045.8 6064.5 5483.9 5536.0 5537.8 5538.1 5538.3 6290.6 6366.3 6367.3 6379.9 6383.0 6234.7 6285.6 6292.4 6318.4 6324.0 6488.9 6489.1 6501.1 6502.2 6522.2 6148.8 6204.6 6220.2 6227.5 6234.3 6280.7 6281.7 6296.2 6305.6 6306.7 4663.8 6175.6 6255.2 6265.9 6267.2 6044.3 6131.9 6138.6 6143.9 6255.6 6052.8 6120.2 6125.3 6134.7 6139.1 6199.8 6238.0 6241.5 6256.5 6259.5 4864.7 5932.9 6074.2 6084.0 6132.0 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | [#1] ext.html Cycles:180 Average:55018.49 Median:36277.55 stddev:102552.10 (282.7%) stddev-sans-first:102757.95 08:46:04 INFO - PROCESS | 1919 | Values: 451.0 472.7 481.9 505.1 507.5 32203.0 40742.4 42235.0 42397.6 44261.3 42652.6 43123.6 43133.9 43139.6 43295.0 8398.3 9168.7 9391.7 9399.2 9405.4 8355.3 11095.7 11361.4 11389.0 11528.0 11263.4 11292.3 11309.8 11333.0 11356.5 8382.7 8607.9 11253.2 11312.4 11334.3 10862.2 11162.5 11183.2 11347.0 11362.6 40611.0 40992.8 41094.8 41132.6 41169.0 3925.3 4009.3 4061.2 4067.1 4078.4 23420.6 29031.6 29239.4 30853.7 31266.8 3225.1 3246.2 3262.8 3294.7 3369.0 374156.0 375369.0 376222.0 376676.1 377309.0 62495.4 62817.7 62849.0 62912.0 62958.0 65405.7 65501.7 65592.3 65596.3 65675.7 16207.3 16211.6 16815.8 16852.8 16881.9 11804.6 12115.5 12860.7 13017.3 13100.7 13478.6 13679.5 16646.9 16687.4 16819.8 5626.0 6714.8 6754.6 6786.0 6848.2 770.3 874.6 898.7 898.9 900.3 29460.7 30230.8 30406.5 31011.8 31034.1 950.5 951.6 1128.5 1131.3 1139.8 14302.6 14716.7 14781.7 14993.0 15078.9 428068.0 430221.0 430706.0 430975.0 431381.0 55413.4 55664.0 55680.0 55793.4 55843.0 1421.5 1446.7 1474.6 1475.5 1480.4 27328.2 28095.3 28644.3 28700.6 28978.0 46295.8 46605.1 46607.3 46609.8 46715.8 353389.5 354731.0 358760.0 358937.0 359010.0 36075.1 36318.0 36611.6 36768.0 36769.8 42543.8 42853.4 43610.8 43642.6 43919.0 35340.8 36263.3 36277.6 37170.0 37533.8 35861.8 35920.8 36481.5 36702.9 36913.8 35709.8 35863.5 35876.3 35997.8 36277.5 30571.4 32745.5 32837.2 32842.3 32881.8 23792.9 23900.2 24265.4 24383.9 24437.4 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | [#2] jquery.html Cycles:180 Average:40079.43 Median:23747.71 stddev:126323.19 (531.9%) stddev-sans-first:126642.37 08:46:04 INFO - PROCESS | 1919 | Values: 369.4 387.8 389.6 399.7 420.2 15344.2 15435.9 18585.9 20648.5 20854.4 21407.7 21537.9 21705.9 21888.8 21986.7 5589.6 5678.3 5744.4 5835.6 5918.8 5984.9 6018.7 6028.2 6029.9 6030.6 3903.8 4032.1 4059.3 4080.4 6550.5 6585.7 6607.0 6607.4 6608.1 6625.6 5136.3 5353.6 5422.9 5464.7 5472.3 13155.5 13362.2 16879.9 25508.7 25976.9 2563.2 2571.5 2641.9 2642.4 2645.3 8922.1 9605.3 9753.8 9866.2 10281.4 1740.3 1789.1 1791.5 1806.8 1809.5 105604.0 112741.0 114180.0 114328.4 114597.0 9924.5 11336.3 11585.2 11736.6 11800.9 15433.9 15479.1 15481.5 15481.8 15514.0 8718.2 8839.6 8852.5 8865.7 8950.0 8764.7 8795.6 8830.8 8905.0 8941.5 3819.8 4647.9 4650.4 4668.8 4731.9 1690.0 1955.2 2004.3 2008.5 2013.3 1008.0 1022.6 1025.9 1030.7 1070.0 16960.4 21620.6 21700.9 21720.9 21782.7 1017.4 1047.1 1050.4 1061.2 1067.6 10344.8 11186.7 11214.8 11241.2 11255.9 737817.0 760328.0 760399.0 773621.0 781486.0 108414.0 114172.8 130379.0 146382.0 162570.0 794.4 964.2 975.2 977.8 978.1 16225.6 18932.9 19223.9 19597.3 19699.6 60161.7 61535.7 62538.7 64156.4 65220.4 93146.5 94184.1 94448.5 94954.0 96586.0 8116.5 8154.0 8436.5 8565.8 8576.3 10703.0 10777.0 12199.4 12635.0 13006.9 11019.4 11070.5 11105.0 11223.9 11532.9 9124.5 10915.6 10937.6 11058.9 11161.8 10599.3 10608.4 10707.7 10894.2 10955.9 8153.5 8208.3 8418.7 8431.3 8443.4 9416.6 10997.5 11144.3 11314.9 11460.9 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | [#3] mootools.html Cycles:180 Average:5465.92 Median:5149.72 stddev:2979.21 (57.9%) stddev-sans-first:2970.86 08:46:04 INFO - PROCESS | 1919 | Values: 1268.6 1453.6 1466.7 1475.5 1478.9 7964.3 8408.7 8414.3 8415.1 8435.4 7298.2 7595.9 7596.0 7945.2 8124.1 1997.9 2314.4 2340.8 2358.9 2360.8 2282.3 2367.6 2376.3 2379.4 2383.5 2061.3 2145.2 2267.4 2344.1 2345.4 2346.0 2351.4 2372.6 2374.0 2378.2 2352.6 2361.9 2385.6 2394.8 2396.3 8319.3 8409.7 8431.9 8438.6 8453.5 5031.1 5178.5 5187.1 5200.8 5203.5 3188.8 3297.0 3365.7 3415.2 3418.1 1115.5 1130.7 1150.6 1172.5 1173.9 10733.0 10856.4 10857.7 10869.0 10879.0 4479.8 4669.1 4759.0 4763.5 4773.5 9550.1 9568.7 9574.6 9575.3 9594.6 5244.8 5254.1 5254.9 5261.9 5275.6 4603.7 4694.1 4730.0 4790.4 4856.0 3841.9 3901.2 3905.5 3947.6 3988.1 1165.2 1258.0 1265.2 1266.8 1288.8 766.0 780.4 806.8 806.9 811.2 5657.5 5739.3 5855.0 5894.8 5923.5 999.5 999.8 1000.4 1003.6 1040.8 2741.8 3864.6 3940.6 3953.5 3987.8 9808.2 10174.6 10182.4 10195.0 10210.2 10124.7 10125.0 10125.4 10128.2 10135.6 7407.2 7765.0 7824.9 8053.1 8059.0 5695.6 5756.3 5875.6 5940.2 5948.1 8724.1 9055.6 9090.8 9316.2 9427.3 9375.7 9394.8 9440.3 9440.7 9513.2 7280.7 7322.3 7418.4 7421.7 7426.1 7845.1 7858.2 7951.7 7959.2 7965.4 6396.0 6940.7 7092.6 7160.8 7281.4 7040.3 7098.9 7143.5 7149.2 7218.7 5489.5 6403.5 6419.7 6428.8 6476.1 4754.0 4816.1 4834.8 4861.5 4986.6 4970.9 5056.4 5140.7 5158.7 5252.1 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | [#4] prototype.html Cycles:180 Average:4394.63 Median:4913.67 stddev:1336.44 (27.2%) stddev-sans-first:1305.27 08:46:04 INFO - PROCESS | 1919 | Values: 350.6 357.4 358.7 358.8 360.6 4398.9 5239.5 5270.4 5283.3 5363.4 4238.9 4674.2 4943.0 5248.7 5271.8 3200.9 3939.2 4021.0 4114.2 4189.9 3640.8 3974.5 4128.9 4189.6 4241.5 3382.3 3761.7 3879.6 4076.6 4136.5 3862.4 3950.8 4114.9 4155.6 4232.9 3076.5 3239.8 3697.9 3710.2 3712.7 4128.6 4728.0 4926.3 5173.4 5232.6 4045.6 4200.2 4562.5 4821.8 4848.7 4616.7 5515.6 5526.7 5559.7 5606.2 3831.6 3844.1 3867.5 3871.8 3876.0 5366.9 5465.8 5839.9 5907.1 5914.1 3425.3 3472.8 3565.9 3924.5 3940.3 3581.0 3772.8 3934.0 3957.7 3995.2 4591.8 4598.5 4631.7 4635.8 4657.2 5031.4 5453.7 5511.3 5616.4 5631.0 1105.7 1160.4 1205.4 1263.1 1265.6 731.8 760.6 812.5 865.3 875.2 4715.8 4735.6 5048.6 5055.1 5222.3 4625.7 5682.5 5714.2 5720.3 5744.6 4326.5 4584.0 4843.7 5158.8 5210.5 2740.7 2745.6 2812.6 2885.7 2901.2 4794.6 5593.2 5702.8 5773.8 5803.5 4843.8 4932.4 4999.8 5137.5 5612.7 4891.5 5017.8 5131.9 5194.6 5366.2 4968.7 5151.8 5208.3 5242.4 5453.7 4540.3 4943.9 5445.4 5460.5 5488.2 4841.6 5621.3 5667.9 5710.9 5732.5 3217.8 3265.8 3587.9 3596.5 3613.7 4564.7 5022.7 5362.8 5384.8 5469.3 4901.0 4992.0 5093.8 5202.6 5310.0 4939.9 5131.4 5206.3 5207.4 5277.9 4258.2 4561.5 5097.3 5545.7 5553.3 5373.8 5381.3 5565.3 5580.7 5677.5 5509.6 5517.9 5552.9 5577.7 5585.3 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - PROCESS | 1919 | [#5] yui.html Cycles:180 Average:20515.40 Median:4275.20 stddev:29261.97 (684.5%) stddev-sans-first:29306.21 08:46:04 INFO - PROCESS | 1919 | Values: 694.4 713.0 731.4 778.2 810.3 14436.0 15012.2 15025.2 15027.9 15055.4 14426.4 14426.8 14446.8 14453.9 14569.5 671.8 698.5 699.7 835.0 850.1 854.1 860.4 877.0 877.2 879.1 916.1 916.3 916.9 917.5 918.6 705.1 733.4 910.0 911.2 912.2 656.7 681.7 686.6 687.3 688.9 15031.0 15379.4 15397.0 15420.3 15462.4 13111.1 14110.6 14111.8 14150.8 14177.0 12493.2 12574.0 12802.3 12857.6 12961.6 3978.0 4345.8 4415.6 4430.0 4438.9 85652.0 104441.0 105330.5 109452.5 109570.5 10358.3 10447.9 10680.5 11261.2 11449.6 21451.9 21624.0 21666.9 21844.9 21970.8 7564.2 7603.2 7663.2 7696.2 7751.0 4271.7 4278.7 4281.6 4319.5 4346.3 3467.5 3503.4 3538.2 3561.6 3572.5 646.6 646.8 653.8 656.8 662.3 637.5 639.1 646.2 648.4 648.6 9523.6 9999.9 10025.3 10037.0 10056.7 620.8 623.7 641.9 653.8 688.4 4656.3 4674.8 4722.3 4744.7 4768.6 106139.9 107584.0 107806.9 108489.5 108934.0 55042.2 64341.0 68989.7 75517.0 85326.0 74390.6 87056.6 87791.1 89816.6 90824.0 8727.6 10262.6 11133.3 11357.8 11447.4 48591.8 53713.0 53808.7 55045.6 55935.2 70054.6 70444.0 70561.0 70916.3 73763.6 13431.9 14257.9 14319.7 14431.4 14490.6 10716.4 14471.3 15793.8 16033.9 16115.0 11413.4 14307.0 14403.7 14406.5 14775.0 12962.6 13392.6 14136.7 14431.6 14437.7 13142.3 13819.2 13833.0 13948.7 14121.6 10548.7 10869.8 11048.5 11263.7 11647.5 8525.3 9712.4 10428.7 11528.4 11732.1 08:46:04 INFO - PROCESS | 1919 | -------- Summary: end -------- 08:46:04 INFO - PROCESS | 1919 | 08:46:04 INFO - TEST-INFO | 1919: exit 0 08:46:04 INFO - TEST-OK | dromaeo_css | took 1118378ms 08:46:04 INFO - TEST-START | kraken 08:46:04 INFO - operating with platform_type : mac_ 08:46:04 INFO - Initialising browser for kraken test... 08:46:04 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmppFnWrP/profile http://localhost:51030/getInfo.html) 08:46:06 INFO - PROCESS | 1923 | __metrics Screen width/height:1600/1200 08:46:06 INFO - PROCESS | 1923 | colorDepth:24 08:46:06 INFO - PROCESS | 1923 | Browser inner width/height: 1024/689 08:46:06 INFO - PROCESS | 1923 | __metrics 08:46:06 INFO - PROCESS | 1923 | 1486399566944 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:46:06 INFO - PROCESS | 1923 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:46:06 INFO - PROCESS | 1923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:07 INFO - TEST-INFO | 1923: exit 0 08:46:07 INFO - Browser initialized. 08:46:07 INFO - Running cycle 1/1 for kraken test... 08:46:07 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmppFnWrP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:19 INFO - PROCESS | 1924 | RSS: Main: 213139456 08:46:19 INFO - PROCESS | 1924 | 08:46:22 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51030/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:23 INFO - PROCESS | 1924 | RSS: Main: 266121216 08:46:23 INFO - PROCESS | 1924 | 08:46:26 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51030/tests/kraken/driver.html?testName=audio-dft) 08:46:26 INFO - PROCESS | 1924 | RSS: Main: 274870272 08:46:26 INFO - PROCESS | 1924 | 08:46:29 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51030/tests/kraken/driver.html?testName=audio-fft) 08:46:30 INFO - PROCESS | 1924 | RSS: Main: 372592640 08:46:30 INFO - PROCESS | 1924 | 08:46:32 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51030/tests/kraken/driver.html?testName=audio-oscillator) 08:46:32 INFO - PROCESS | 1924 | RSS: Main: 275001344 08:46:32 INFO - PROCESS | 1924 | 08:46:35 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:35 INFO - PROCESS | 1924 | RSS: Main: 276459520 08:46:35 INFO - PROCESS | 1924 | 08:46:38 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51030/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:39 INFO - PROCESS | 1924 | RSS: Main: 316289024 08:46:39 INFO - PROCESS | 1924 | 08:46:41 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51030/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:42 INFO - PROCESS | 1924 | RSS: Main: 318218240 08:46:42 INFO - PROCESS | 1924 | 08:46:45 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51030/tests/kraken/driver.html?testName=json-parse-financial) 08:46:45 INFO - PROCESS | 1924 | RSS: Main: 313643008 08:46:45 INFO - PROCESS | 1924 | 08:46:47 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:46:48 INFO - PROCESS | 1924 | RSS: Main: 293867520 08:46:48 INFO - PROCESS | 1924 | 08:46:50 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:46:50 INFO - PROCESS | 1924 | RSS: Main: 295567360 08:46:50 INFO - PROCESS | 1924 | 08:46:52 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:46:53 INFO - PROCESS | 1924 | RSS: Main: 298733568 08:46:53 INFO - PROCESS | 1924 | 08:46:56 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:46:57 INFO - PROCESS | 1924 | RSS: Main: 316223488 08:46:57 INFO - PROCESS | 1924 | 08:47:00 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:00 INFO - PROCESS | 1924 | RSS: Main: 309923840 08:47:00 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:51030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51030/tests/kraken/driver.html?testName=ai-astar) 08:47:02 INFO - PROCESS | 1924 | RSS: Main: 355606528 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | __start_tp_report 08:47:02 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 08:47:02 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 08:47:02 INFO - PROCESS | 1924 | |i|pagename|runs| 08:47:02 INFO - PROCESS | 1924 | |0;ai-astar;116;114;113;114;114;114;114;114;111;115 08:47:02 INFO - PROCESS | 1924 | |1;audio-beat-detection;144;108;107;141;108;111;103;107;128;112 08:47:02 INFO - PROCESS | 1924 | |2;audio-dft;183;182;181;184;181;183;184;180;183;184 08:47:02 INFO - PROCESS | 1924 | |3;audio-fft;84;59;58;90;62;58;58;57;75;58 08:47:02 INFO - PROCESS | 1924 | |4;audio-oscillator;86;69;87;93;98;101;92;67;69;79 08:47:02 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;89;87;89;87;89;85;89;86;89;85 08:47:02 INFO - PROCESS | 1924 | |6;imaging-darkroom;97;97;97;97;97;98;97;98;98;97 08:47:02 INFO - PROCESS | 1924 | |7;imaging-desaturate;87;87;87;87;87;84;86;87;86;85 08:47:02 INFO - PROCESS | 1924 | |8;json-parse-financial;57;53;53;54;57;57;57;57;57;58 08:47:02 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;69;74;65;75;73;70;70;71;71;71 08:47:02 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;81;99;102;103;89;86;83;84;82;88 08:47:02 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;142;128;140;138;141;145;153;131;192;136 08:47:02 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;167;167;171;168;166;169;157;165;175;169 08:47:02 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;67;68;67;65;66;65;65;65;65;65 08:47:02 INFO - PROCESS | 1924 | __end_tp_report 08:47:02 INFO - PROCESS | 1924 | __start_cc_report 08:47:02 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,2124 08:47:02 INFO - PROCESS | 1924 | __end_cc_report 08:47:02 INFO - PROCESS | 1924 | __startTimestamp1486399622765__endTimestamp 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | ------- Summary: start ------- 08:47:02 INFO - PROCESS | 1924 | Number of tests: 14 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.29 (1.1%) stddev-sans-first:1.12 08:47:02 INFO - PROCESS | 1924 | Values: 116.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 111.0 115.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:111.50 stddev:15.07 (13.5%) stddev-sans-first:12.39 08:47:02 INFO - PROCESS | 1924 | Values: 144.0 108.0 107.0 141.0 108.0 111.0 103.0 107.0 128.0 112.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 08:47:02 INFO - PROCESS | 1924 | Values: 183.0 182.0 181.0 184.0 181.0 183.0 184.0 180.0 183.0 184.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.50 stddev:12.40 (20.5%) stddev-sans-first:11.29 08:47:02 INFO - PROCESS | 1924 | Values: 84.0 59.0 58.0 90.0 62.0 58.0 58.0 57.0 75.0 58.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:86.50 stddev:12.50 (14.5%) stddev-sans-first:13.24 08:47:02 INFO - PROCESS | 1924 | Values: 86.0 69.0 87.0 93.0 98.0 101.0 92.0 67.0 69.0 79.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:89.00 stddev:1.72 (1.9%) stddev-sans-first:1.73 08:47:02 INFO - PROCESS | 1924 | Values: 89.0 87.0 89.0 87.0 89.0 85.0 89.0 86.0 89.0 85.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:47:02 INFO - PROCESS | 1924 | Values: 97.0 97.0 97.0 97.0 97.0 98.0 97.0 98.0 98.0 97.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:87.00 stddev:1.06 (1.2%) stddev-sans-first:1.09 08:47:02 INFO - PROCESS | 1924 | Values: 87.0 87.0 87.0 87.0 87.0 84.0 86.0 87.0 86.0 85.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.89 (3.3%) stddev-sans-first:1.96 08:47:02 INFO - PROCESS | 1924 | Values: 57.0 53.0 53.0 54.0 57.0 57.0 57.0 57.0 57.0 58.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:2.81 (4.0%) stddev-sans-first:2.89 08:47:02 INFO - PROCESS | 1924 | Values: 69.0 74.0 65.0 75.0 73.0 70.0 70.0 71.0 71.0 71.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:85.00 stddev:8.46 (10.0%) stddev-sans-first:8.37 08:47:02 INFO - PROCESS | 1924 | Values: 81.0 99.0 102.0 103.0 89.0 86.0 83.0 84.0 82.0 88.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:141.50 stddev:18.06 (12.8%) stddev-sans-first:19.13 08:47:02 INFO - PROCESS | 1924 | Values: 142.0 128.0 140.0 138.0 141.0 145.0 153.0 131.0 192.0 136.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.50 stddev:4.62 (2.7%) stddev-sans-first:4.90 08:47:02 INFO - PROCESS | 1924 | Values: 167.0 167.0 171.0 168.0 166.0 169.0 157.0 165.0 175.0 169.0 08:47:02 INFO - PROCESS | 1924 | 08:47:02 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:1.14 (1.7%) stddev-sans-first:1.12 08:47:02 INFO - PROCESS | 1924 | Values: 67.0 68.0 67.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 08:47:02 INFO - PROCESS | 1924 | -------- Summary: end -------- 08:47:02 INFO - PROCESS | 1924 | 08:47:03 INFO - TEST-INFO | 1924: exit 0 08:47:03 INFO - TEST-OK | kraken | took 58926ms 08:47:03 INFO - SUITE-END | took 1177s 08:47:03 INFO - Completed test suite (00:19:37) 08:47:03 INFO - javascript benchmark 08:47:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.1069216657584, 3381.8478168482416, 3395.8981230563077, 3403.659634036598, 3454.618152738904, 5818.301803783546, 5876.44173803488, 5880.411958804118, 5882.558808089394, 5887.293524777027, 5800.47795698387, 5880.970595147019, 5900.262467191601, 5901.881962360751, 5907.0, 5248.5276325130735, 5286.418493965661, 5295.602829787762, 5380.381256155533, 5384.138537833947, 5231.503007214308, 5263.789448422078, 5274.103402421598, 5376.086065368897, 5391.272178255944, 5306.602004849632, 5347.358317001966, 5348.705821179834, 5351.678899266057, 5354.973225133888, 5321.122014867561, 5346.572274218053, 5367.677939323653, 5379.757910894019, 5395.568354531628, 5245.711485868275, 5327.121025030865, 5333.2266821310695, 5339.385970613391, 5374.355077390738, 5937.910931336033, 5941.2276404067625, 5942.851428714317, 5984.491318237955, 5985.7306421210715, 6156.322804491502, 6206.596571222856, 6257.530685198628, 6293.968530157365, 6299.559030867841, 6205.255369355661, 6211.440970312694, 6238.688065596702, 6281.905771413432, 6342.6511541865175, 6024.969875150597, 6028.246469191351, 6031.790240117792, 6043.395660433922, 6079.787207447718, 6416.230052393649, 6428.100065990765, 6434.131392262078, 6451.774187903401, 6458.6770661466735, 5118.948810511847, 6125.490313351988, 6132.294786099566, 6185.226846644169, 6189.81430557084, 6289.0880822280515, 6291.96854015727, 6302.149209856702, 6311.2426508819235, 6312.684365781693, 6223.657698826608, 6234.220722409699, 6235.345288744707, 6264.498840092781, 6272.717727702265, 6172.9074063889075, 6215.440610345, 6229.190205273286, 6271.843203919847, 6272.905906411407, 5027.698338099725, 5048.0, 5053.938672878663, 5077.619178561623, 5079.263506791494, 4502.16709908668, 4505.121501307213, 4510.188166130128, 4510.977445112819, 4539.886502837456, 5734.426557344315, 5742.712864356766, 5965.403459654, 5982.952983227918, 5987.9101813472835, 6215.192025036717, 6257.7809776658505, 6268.059791031382, 6299.212598425197, 6300.243970723543, 5767.653940763567, 5984.7606095756555, 6032.698365081728, 6045.758169673164, 6064.454199122012, 5483.945160548344, 5535.975844468786, 5537.7784888604, 5538.113901775697, 5538.307711536058, 6290.622562646256, 6366.299707032223, 6367.3314301997625, 6379.872402552016, 6383.042543618494, 6234.657093859882, 6285.5600107992, 6292.433680968552, 6318.368163183645, 6323.9683801580695, 6488.935110648833, 6489.123968264224, 6501.08984742127, 6502.187226596676, 6522.15212022434, 6148.846278843064, 6204.565680402328, 6220.191375121205, 6227.50179985591, 6234.251889773256, 6280.7487700491465, 6281.654509002049, 6296.244450665949, 6305.558610897193, 6306.716197771203, 4663.766811659471, 6175.62946223228, 6255.218097737783, 6265.937340626535, 6267.185265915584, 6044.335123136363, 6131.938680613137, 6138.633639632548, 6143.938560614515, 6255.593386429868, 6052.757889684363, 6120.190246383004, 6125.296497837281, 6134.650895842656, 6139.058058263141, 6199.845003874939, 6238.0, 6241.500679945502, 6256.499480041677, 6259.530535209787, 4864.6594738369395, 5932.911006334994, 6074.210352654127, 6083.969580152071, 6131.96934015327], "value": 5795.804216118588, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.97068690535133, 472.7352682497801, 481.8723038394826, 505.0958783777039, 507.53306957599006, 32203.03390898274, 40742.388864167064, 42235.0, 42397.57602423975, 44261.336079958826, 42652.57347426525, 43123.568764312346, 43133.92165195871, 43139.56860431395, 43295.0, 8398.328133749286, 9168.679096231617, 9391.718248452557, 9399.248060155205, 9405.388649737779, 8355.331573474137, 11095.667129986114, 11361.375124368156, 11389.031932285765, 11527.962483376494, 11263.380514071763, 11292.266002709797, 11309.773804523904, 11332.980031797137, 11356.545738170464, 8382.706605268786, 8607.913920860774, 11253.212275140744, 11312.377819219939, 11334.263272887318, 10862.185336099825, 11162.497687603996, 11183.217174797768, 11347.0, 11362.602308919231, 40611.0, 40992.79503602493, 41094.76715698534, 41132.588674113475, 41169.0, 3925.2738243424774, 4009.3184158693093, 4061.208064427438, 4067.1458993611377, 4078.4290199372113, 23420.64869026966, 29031.564526532118, 29239.41521169586, 30853.691463085306, 31266.843665781755, 3225.0969728476066, 3246.1722260823576, 3262.755293353008, 3294.7034766870856, 3368.9663103369144, 374156.0, 375369.0, 376222.0, 376676.1166194179, 377309.0, 62495.375046249865, 62817.68591157015, 62849.0, 62912.0, 62958.0, 65405.69188616201, 65501.67249163723, 65592.34407655957, 65596.34403655998, 65675.67162164254, 16207.270672819515, 16211.594710132342, 16815.831841681673, 16852.83147168537, 16881.91559042197, 11804.586839460577, 12115.515379384902, 12860.742785144432, 13017.349132543335, 13100.672483187996, 13478.595642130556, 13679.452821887013, 16646.916765416096, 16687.415940442028, 16819.831801681827, 5625.971870140623, 6714.798556043326, 6754.628495432798, 6786.0, 6848.212455567574, 770.3067239484396, 874.6020560644891, 898.6630013744846, 898.8561830107152, 900.3157600223877, 29460.705392945798, 30230.84884575563, 30406.54390184149, 31011.84494077515, 31034.0689779307, 950.5342382232657, 951.5765484359532, 1128.537299707116, 1131.281636161027, 1139.8233273842568, 14302.642433939027, 14716.705665886622, 14781.704365912621, 14992.95049346557, 15078.924605376902, 428068.0, 430221.0, 430706.0, 430975.0, 431381.0, 55413.44586554083, 55664.0, 55680.0, 55793.44206557883, 55843.0, 1421.4882642248783, 1446.681730019415, 1474.6387135151956, 1475.4762059468949, 1480.4004378226834, 27328.180154595393, 28095.297617559725, 28644.283892902844, 28700.629194212743, 28978.0, 46295.76852115718, 46605.06789864116, 46607.30089048735, 46609.766951165024, 46715.766421167675, 353389.4661053459, 354731.0, 358760.0, 358937.0, 359010.0, 36075.09812254609, 36318.0, 36611.63388366082, 36768.0, 36769.816150919076, 42543.78728106464, 42853.35719964141, 43610.781946090065, 43642.56357436512, 43919.0, 35340.76307329231, 36263.27473450569, 36277.63722362848, 37170.0, 37533.81233093926, 35861.82069089638, 35920.820395897856, 36481.452778207815, 36702.89891303265, 36913.815430922674, 35709.75015874432, 35863.48386713129, 35876.28247435089, 35997.82001089978, 36277.455838162976, 30571.388572228876, 32745.508817368234, 32837.17907052247, 32842.343153137284, 32881.835590821895, 23792.881035595405, 23900.163494277618, 24265.393365165306, 24383.878080609484, 24437.38906527351], "value": 19376.28425348175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.3665363900909, 387.8351700527275, 389.6045513803489, 399.6682753314749, 420.1848414076691, 15344.156071416082, 15435.922820385897, 18585.907070464647, 20648.48378790531, 20854.374368768924, 21407.67888481674, 21537.892310538464, 21705.891470542625, 21888.781112188874, 21986.670199946973, 5589.580781441398, 5678.290213723285, 5744.368119506851, 5835.649861008332, 5918.763249470016, 5984.8503787405225, 6018.6990650467305, 6028.246469191351, 6029.939700603004, 6030.63816171029, 3903.8243279052367, 4032.0726232966435, 4059.289624315748, 4080.367543030835, 6550.508711846607, 6585.703643336037, 6607.041978913078, 6607.372299631527, 6608.107905432777, 6625.569337993015, 5136.255242989746, 5353.625246232766, 5422.864428389283, 5464.6994415307145, 5472.315960504937, 13155.539556115586, 13362.198268103848, 16879.91560042192, 25508.74491255082, 25976.87011564949, 2563.205406324027, 2571.4985577812336, 2641.8811153497945, 2642.379040925381, 2645.2725500487327, 8922.10778922109, 9605.327627066108, 9753.756156096084, 9866.210703143732, 10281.383117012929, 1740.2864825421643, 1789.0875653416722, 1791.5342011077084, 1806.765120534322, 1809.5295223242051, 105604.0, 112741.0, 114180.0, 114328.42835785852, 114597.0, 9924.50377481123, 11336.263142895685, 11585.246958947642, 11736.647900562997, 11800.940995295141, 15433.922830385776, 15479.071255724693, 15481.5355539334, 15481.767773483407, 15513.991590546579, 8718.17177368149, 8839.602217900081, 8852.513111778786, 8865.734027979172, 8949.955250223837, 8764.693235736719, 8795.648174072965, 8830.823383532423, 8905.0, 8941.46351218929, 3819.789911554891, 4647.86056418308, 4650.37219975299, 4668.8132474701315, 4731.881702957454, 1690.0451245046509, 1955.1788248935482, 2004.3285499357587, 2008.5480766827638, 2013.2752209204675, 1007.9970429422625, 1022.5858527296457, 1025.9025392587691, 1030.6804890483975, 1070.0, 16960.406385776438, 21620.567588648453, 21700.91495425254, 21720.89139554292, 21782.673259901116, 1017.4251547875426, 1047.1099565369375, 1050.422267752733, 1061.2093989977516, 1067.5729708116814, 10344.793104137874, 11186.664400068012, 11214.775704485864, 11241.213115081866, 11255.943720281346, 737817.0, 760328.0, 760399.0, 773621.0, 781486.0, 108414.0, 114172.783738001, 130379.0, 146382.0, 162570.0, 794.4200733464488, 964.1804466203811, 975.2393133355994, 977.8093271812071, 978.0512902484578, 16225.59436014109, 18932.905335473235, 19223.90388048051, 19597.31409400664, 19699.606007880047, 60161.69919150551, 61535.6923215381, 62538.68730656317, 64156.35843641504, 65220.412877292205, 93146.53426732823, 94184.05815942027, 94448.52775736077, 94954.0, 96586.0, 8116.513009219229, 8153.959230203811, 8436.53599052058, 8565.785855353666, 8576.31389488827, 10703.036726694323, 10777.0, 12199.421691079075, 12635.0, 13006.934965325112, 11019.449027548751, 11070.501827417624, 11105.00054995022, 11223.887761122285, 11532.94233528827, 9124.49815260167, 10915.563377464812, 10937.632795900512, 11058.889411105785, 11161.832572511257, 10599.258051936291, 10608.363498190134, 10707.678769636923, 10894.182936279652, 10955.890441095487, 8153.470024448629, 8208.343332533503, 8418.747437576883, 8431.28334091609, 8443.40896137289, 9416.576254068721, 10997.505112269808, 11144.33134011962, 11314.886851131712, 11460.885391145981], "value": 9670.54600178245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.6257554021563, 1453.6220582648511, 1466.7139907717992, 1475.4762059468892, 1478.91126532408, 7964.323032542234, 8408.705695300665, 8414.326853851693, 8415.116412776655, 8435.40952133351, 7298.160711518177, 7595.924040759591, 7596.0, 7945.245201705843, 8124.146964568724, 1997.8901160436171, 2314.3866875278063, 2340.7776261255153, 2358.929232123039, 2360.799332056777, 2282.3267136194863, 2367.562001029815, 2376.275236053003, 2379.3694670912137, 2383.4994651123197, 2061.268249771332, 2145.1633862793524, 2267.3764714703507, 2344.0623750499767, 2345.3901985483726, 2345.9677741793726, 2351.423901144222, 2372.5966585680476, 2373.964390534143, 2378.1795280628157, 2352.564775516535, 2361.9173328933575, 2385.630227314769, 2394.8084153267696, 2396.3290278721984, 8319.251267385964, 8409.747707568782, 8431.873521897176, 8438.57807109642, 8453.450525715809, 5031.069252188357, 5178.533931946105, 5187.118189907725, 5200.8179713710215, 5203.453637368059, 3188.7608429367892, 3296.950545741816, 3365.730741540671, 3415.2315728960784, 3418.1454636340914, 1115.5370521233679, 1130.7399298161386, 1150.6030419505257, 1172.5192671004932, 1173.87606558674, 10732.980366865213, 10856.402897840615, 10857.67426977192, 10869.0, 10879.020888120029, 4479.7536135512855, 4669.112868554964, 4758.976205118952, 4763.499832517605, 4773.498782627844, 9550.092741189575, 9568.665096721581, 9574.617015319449, 9575.329726919188, 9594.616215351307, 5244.842654720364, 5254.106801843695, 5254.868628284247, 5261.868453288698, 5275.60432967529, 4603.654725895504, 4694.108119457293, 4729.95270047302, 4790.353302304214, 4856.028794241166, 3841.9423708644395, 3901.1612503311926, 3905.511811023622, 3947.6052394760295, 3988.082740969593, 1165.2018367418345, 1257.9559715409916, 1265.2092442223611, 1266.7593157300269, 1288.845338559379, 765.9812449442228, 780.4185881518192, 806.7620052084649, 806.9233422824823, 811.1807074854439, 5657.4908258256955, 5739.339975902742, 5855.0, 5894.764209431661, 5923.49650279731, 999.4503023337136, 999.7600575861741, 1000.4147573669485, 1003.6386900715737, 1040.8074506216374, 2741.7943654226015, 3864.613538646113, 3940.625640564142, 3953.5058117735284, 3987.80060996949, 9808.16630586408, 10174.643887464052, 10182.439965801805, 10194.980501949894, 10210.234232432596, 10124.746881328027, 10125.038121378457, 10125.443100629389, 10128.189744820544, 10135.594576216869, 7407.222241664547, 7764.961175194087, 7824.92175078242, 8053.07389650186, 8058.959705201437, 5695.572832037531, 5756.3380211276235, 5875.588708790515, 5940.198073260228, 5948.13752005948, 8724.138447632738, 9055.637774488947, 9090.772730681785, 9316.20812230968, 9427.292953028413, 9375.718728438158, 9394.812103758024, 9440.291978101806, 9440.716778496657, 9513.238940884574, 7280.672369743268, 7322.340989310987, 7418.406527477897, 7421.703131874665, 7426.108866936002, 7845.13703492604, 7858.174891636296, 7951.721689740832, 7959.204079591995, 7965.362770978424, 6396.0, 6940.722371105099, 7092.574445533284, 7160.785176444715, 7281.381082608038, 7040.295970402919, 7098.893516597152, 7143.499955003308, 7149.177844547944, 7218.675159617725, 5489.505944465017, 6403.455706265019, 6419.711112999833, 6428.8071357859335, 6476.093346931528, 4753.952460475351, 4816.084943860656, 4834.830780922651, 4861.465238823655, 4986.551210391082, 4970.900581988412, 5056.443791182894, 5140.691558506502, 5158.742062896765, 5252.054630166606], "value": 4432.693844074239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.57930483419887, 357.42097801561465, 358.652107455768, 358.8331425886962, 360.5871277387391, 4398.868033958983, 5239.52844244018, 5270.446603106671, 5283.313169287992, 5363.383210930744, 4238.936415953755, 4674.247157316006, 4943.0, 5248.737563121847, 5271.840195157069, 3200.9039728808175, 3939.1924655445637, 4020.9746514638728, 4114.2308807212885, 4189.874303770892, 3640.7633503822167, 3974.469105220037, 4128.855490057848, 4189.560096189902, 4241.533431322552, 3382.2897191589673, 3761.736678432511, 3879.573246942834, 4076.5719599442077, 4136.482939632546, 3862.4206369044587, 3950.822213000422, 4114.897127571805, 4155.589757940403, 4232.936505952413, 3076.507758758588, 3239.8455027406744, 3697.890632810146, 3710.2023065040876, 3712.6658600726064, 4128.646671397305, 4728.0, 4926.334944782444, 5173.3533308336455, 5232.581393488512, 4045.6358927696647, 4200.2149086638365, 4562.51718191589, 4821.758912054418, 4848.660593758438, 4616.699914505546, 5515.573147814948, 5526.723663816793, 5559.722013899329, 5606.243157173811, 3831.578526362098, 3844.1350696093436, 3867.4943690600417, 3871.825767840454, 3876.0425984877456, 5366.946330536644, 5465.7913406677035, 5839.883202335972, 5907.084401917709, 5914.053751399755, 3425.3491836550975, 3472.808995505221, 3565.857365705395, 3924.529056513237, 3940.310445671996, 3581.0, 3772.754770939935, 3933.996830808183, 3957.7229593928723, 3995.20095980805, 4591.816327346869, 4598.517155698671, 4631.652626053059, 4635.791389387486, 4657.231556793091, 5031.396232452129, 5453.727313634303, 5511.283533140666, 5616.354119276336, 5630.95827271956, 1105.7449794483318, 1160.3502038858267, 1205.3852535207106, 1263.0716423428773, 1265.5823578219165, 731.8426538294292, 760.62729262662, 812.4962523235632, 865.3380164174412, 875.2254254984384, 4715.7877895494785, 4735.608517698609, 5048.601914090777, 5055.090083784954, 5222.321098257202, 4625.676202665848, 5682.488576028178, 5714.228579141763, 5720.2849643794525, 5744.569157313218, 4326.507354962596, 4584.020386748573, 4843.733594652328, 5158.819441319536, 5210.452902445189, 2740.671119465677, 2745.5881617757095, 2812.6343575335077, 2885.653721553427, 2901.1876674531163, 4794.640401969867, 5593.244911936918, 5702.800401985911, 5773.826785196451, 5803.5357171426185, 4843.806247750121, 4932.358793356912, 4999.750012499433, 5137.508308470389, 5612.737134144785, 4891.51084891508, 5017.799288028438, 5131.897362052738, 5194.584433245332, 5366.2487251784005, 4968.726894870337, 5151.793928242828, 5208.270842082035, 5242.370915490165, 5453.682185071408, 4540.322338905497, 4943.8516844494725, 5445.401005889428, 5460.535854452416, 5488.240555219687, 4841.562490631691, 5621.301775148034, 5667.85830354228, 5710.8572285691525, 5732.512736417451, 3217.790843595159, 3265.7877237979455, 3587.9282414352087, 3596.460530920383, 3613.6928361089604, 4564.748938808265, 5022.748862556785, 5362.758675859518, 5384.788422604883, 5469.2616496772425, 4901.0, 4991.951690144965, 5093.821716240062, 5202.60980426462, 5310.0, 4939.901201975868, 5131.435542090442, 5206.318745845968, 5207.3751149862255, 5277.859673494265, 4258.169656916872, 4561.475430325422, 5097.337346144977, 5545.722713864371, 5553.250311207935, 5373.764034272217, 5381.3004309441085, 5565.276514053147, 5580.665160090408, 5677.545796336366, 5509.614326997072, 5517.917231241454, 5552.916706249491, 5577.653407955195, 5585.301837270341], "value": 3977.8113936892455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4201591670954, 712.9536580122289, 731.3673672273482, 778.1518145221711, 810.2667086286908, 14436.0, 15012.174330411837, 15025.17361545116, 15027.924860375682, 15055.397784088651, 14426.42294308229, 14426.783598246035, 14446.783298250535, 14453.92773036136, 14569.490067847628, 671.7648822911991, 698.5319835710086, 699.7096205074888, 834.9582520873962, 850.090403268503, 854.0989256334565, 860.423516244118, 877.0221203358274, 877.1579283887476, 879.1077056787366, 916.0701887584107, 916.3493919317293, 916.9358144929857, 917.499962520428, 918.5728636184173, 705.1326867952447, 733.435254853765, 909.9681511147144, 911.2345629671108, 912.238281035333, 656.668382466856, 681.6591704147926, 686.5571706249441, 687.3058211206667, 688.9242183359827, 15031.022983506036, 15379.384824607003, 15397.0, 15420.306086226146, 15462.381504739797, 13111.147775394664, 14110.647233819236, 14111.78832317516, 14150.787738183935, 14177.0, 12493.18794278369, 12574.0, 12802.295873726942, 12857.614271571867, 12961.611151665371, 3978.0054986253435, 4345.760983145926, 4415.580519850609, 4429.955700442986, 4438.866833994985, 85652.0, 104441.0, 105330.47334763354, 109452.4527377358, 109570.45214773875, 10358.326708763907, 10447.94776026115, 10680.465976701134, 11261.155413344031, 11449.59926402572, 21451.892740536197, 21624.02691878869, 21666.89166554157, 21844.890775546337, 21970.780292196872, 7564.18432878987, 7603.163651998276, 7663.157052724196, 7696.230376962371, 7751.0, 4271.700980931305, 4278.700490965664, 4281.550437204111, 4319.460067491564, 4346.282863327516, 3467.497212904115, 3503.404421248394, 3538.2039041216035, 3561.5904171020147, 3572.5355703758346, 646.6281887914467, 646.7574659502686, 653.8201994451564, 656.7569999100364, 662.2582707367683, 637.4868231073938, 639.1435476461564, 646.1664452855857, 648.3905129178557, 648.5719425179453, 9523.619055237852, 9999.850032243103, 10025.298229124037, 10037.0, 10056.69829905104, 620.8385819686823, 623.6850390552833, 641.9390157934989, 653.7777155767062, 688.4148473797233, 4656.254999200111, 4674.766261686902, 4722.315264286659, 4744.691595046311, 4768.61851051915, 106139.93860061455, 107584.0, 107806.92193077969, 108489.45755271331, 108934.0, 55042.17436738372, 64341.0, 68989.65505172542, 75517.0, 85326.0, 74390.62804685942, 87056.564717176, 87791.12208877958, 89816.5509172463, 90824.0, 8727.56362181901, 10262.560585186253, 11133.332000080021, 11357.829632555684, 11447.427628618703, 48591.757041215984, 53713.0, 53808.73095634653, 55045.62385940384, 55935.16097258463, 70054.64972675104, 70444.0, 70561.0, 70916.29083709097, 73763.63118184375, 13431.865681343452, 14257.857421425653, 14319.713605728035, 14431.42274309016, 14490.565283041526, 10716.410597416905, 14471.27643617794, 15793.763093553376, 16033.919830400773, 16115.0, 11413.372264525531, 14307.0, 14403.711925761636, 14406.495772647908, 14774.96575239723, 12962.611121666365, 13392.598222053353, 14136.717265654836, 14431.639209019439, 14437.711245774815, 13142.342882855628, 13819.239941803296, 13833.0, 13948.721025579229, 14121.646958826112, 10548.736281593021, 10869.836952445561, 11048.502817373077, 11263.745811095941, 11647.534098635959, 8525.317974562144, 9712.417254964725, 10428.705684749646, 11528.365939873387, 11732.12009099304], "value": 7538.428374862741, "unit": "score"}], "name": "dromaeo_css", "value": 7242.9006667514195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 111.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 107.0, 141.0, 108.0, 111.0, 103.0, 107.0, 128.0, 112.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 181.0, 184.0, 181.0, 183.0, 184.0, 180.0, 183.0, 184.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 90.0, 62.0, 58.0, 58.0, 57.0, 75.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 87.0, 93.0, 98.0, 101.0, 92.0, 67.0, 69.0, 79.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 89.0, 85.0, 89.0, 86.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 98.0, 97.0, 98.0, 98.0, 97.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 87.0, 84.0, 86.0, 87.0, 86.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 54.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 65.0, 75.0, 73.0, 70.0, 70.0, 71.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 99.0, 102.0, 103.0, 89.0, 86.0, 83.0, 84.0, 82.0, 88.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 128.0, 140.0, 138.0, 141.0, 145.0, 153.0, 131.0, 192.0, 136.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 171.0, 168.0, 166.0, 169.0, 157.0, 165.0, 175.0, 169.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1428.8, "alertThreshold": 2.0}]} 08:47:04 INFO - Return code: 0 08:47:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:47:04 ERROR - # TBPL SUCCESS # 08:47:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:04 INFO - 2017-02-06 08:47:04.092 screenresolution[1928:17690] starting screenresolution argv=screenresolution get 08:47:04 INFO - 2017-02-06 08:47:04.094 screenresolution[1928:17690] Display 0: 1600x1200x32@60 08:47:04 INFO - 2017-02-06 08:47:04.100 screenresolution[1929:17693] starting screenresolution argv=screenresolution list 08:47:04 INFO - Available Modes on Display 0 08:47:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:04 INFO - Intel Iris: 08:47:04 INFO - Chipset Model: Intel Iris 08:47:04 INFO - Type: GPU 08:47:04 INFO - Bus: Built-In 08:47:04 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:04 INFO - Vendor: Intel (0x8086) 08:47:04 INFO - Device ID: 0x0a2e 08:47:04 INFO - Revision ID: 0x0009 08:47:04 INFO - Displays: 08:47:04 INFO - Display: 08:47:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:04 INFO - Display Serial Number: 1600x1200 60 08:47:04 INFO - Main Display: Yes 08:47:04 INFO - Mirror: Off 08:47:04 INFO - Online: Yes 08:47:04 INFO - Rotation: Supported 08:47:04 INFO - Return code: 0 08:47:04 INFO - Running post-action listener: _resource_record_post_action 08:47:04 INFO - [mozharness: 2017-02-06 16:47:04.345100Z] Finished run-tests step (success) 08:47:04 INFO - Running post-run listener: _resource_record_post_run 08:47:04 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 512000; Write bytes: 508350464; Read time: 6; Write time: 1616 08:47:04 INFO - TinderboxPrint: CPU usage
53.5% 08:47:04 INFO - TinderboxPrint: I/O read bytes / time
512,000 / 6 08:47:04 INFO - TinderboxPrint: I/O write bytes / time
508,350,464 / 1,616 08:47:04 INFO - TinderboxPrint: CPU idle
2,230.2 (46.5%) 08:47:04 INFO - TinderboxPrint: CPU system
956.7 (20.0%) 08:47:04 INFO - TinderboxPrint: CPU user
1,606.8 (33.5%) 08:47:04 INFO - TinderboxPrint: Swap in / out
207,953,920 / 0 08:47:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205134336; Write bytes: 198754304; Read time: 15791; Write time: 437 08:47:04 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 471040; Write bytes: 298635264; Read time: 5; Write time: 1143 08:47:04 INFO - Running post-run listener: _upload_blobber_files 08:47:04 INFO - Blob upload gear active. 08:47:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:04 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 08:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:47:05 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:06 INFO - (blobuploader) - INFO - Done attempting. 08:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:07 INFO - (blobuploader) - INFO - Done attempting. 08:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:47:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:09 INFO - (blobuploader) - INFO - Done attempting. 08:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:12 INFO - (blobuploader) - INFO - Done attempting. 08:47:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:12 INFO - Return code: 0 08:47:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0318df2408a689edcde44fb9e4cf454159a05bd17e4e67a1ed99c370db289bba7140537b151e4a70acba5afba07f3471ef710c017117a0f84e7ab6ca9066b1a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49dbb78ca028a92d639d5c92b8bd30c444b189338bfe0dc0cb372104050bea78d2198cee51a524c7993735bc01f8369425fae4620dffb9db00cf97812f8b4a05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/783702d81225b0b0f83db4f739bba82552f7c64c7e2b1c4dba2406e25e83ac9ec645599e0dd4f72598a47abec3d93a8d7ab391be55760a50023f3b6a364b3293", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19a044a221870c6ab8053c066fe463c38c49e1cf985c0fd5d4f1fb584a8b6330d4961a32cc3ec35cb4fc7d0e463770f27272595ba169d5bcd681181eba61b6dc"} 08:47:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:12 INFO - Contents: 08:47:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0318df2408a689edcde44fb9e4cf454159a05bd17e4e67a1ed99c370db289bba7140537b151e4a70acba5afba07f3471ef710c017117a0f84e7ab6ca9066b1a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49dbb78ca028a92d639d5c92b8bd30c444b189338bfe0dc0cb372104050bea78d2198cee51a524c7993735bc01f8369425fae4620dffb9db00cf97812f8b4a05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/783702d81225b0b0f83db4f739bba82552f7c64c7e2b1c4dba2406e25e83ac9ec645599e0dd4f72598a47abec3d93a8d7ab391be55760a50023f3b6a364b3293", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19a044a221870c6ab8053c066fe463c38c49e1cf985c0fd5d4f1fb584a8b6330d4961a32cc3ec35cb4fc7d0e463770f27272595ba169d5bcd681181eba61b6dc"} 08:47:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:12 INFO - Copying logs to upload dir... 08:47:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.022642 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-06 08:47:12.137031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 08:47:12.140688) ========= 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.XERcr2VNkF/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.65wZrS5GCs/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0318df2408a689edcde44fb9e4cf454159a05bd17e4e67a1ed99c370db289bba7140537b151e4a70acba5afba07f3471ef710c017117a0f84e7ab6ca9066b1a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49dbb78ca028a92d639d5c92b8bd30c444b189338bfe0dc0cb372104050bea78d2198cee51a524c7993735bc01f8369425fae4620dffb9db00cf97812f8b4a05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/783702d81225b0b0f83db4f739bba82552f7c64c7e2b1c4dba2406e25e83ac9ec645599e0dd4f72598a47abec3d93a8d7ab391be55760a50023f3b6a364b3293", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19a044a221870c6ab8053c066fe463c38c49e1cf985c0fd5d4f1fb584a8b6330d4961a32cc3ec35cb4fc7d0e463770f27272595ba169d5bcd681181eba61b6dc"} build_url:https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011101 build_url: 'https://queue.taskcluster.net/v1/task/OH8MwQCAQwWvonlaOf3TOw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0318df2408a689edcde44fb9e4cf454159a05bd17e4e67a1ed99c370db289bba7140537b151e4a70acba5afba07f3471ef710c017117a0f84e7ab6ca9066b1a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/49dbb78ca028a92d639d5c92b8bd30c444b189338bfe0dc0cb372104050bea78d2198cee51a524c7993735bc01f8369425fae4620dffb9db00cf97812f8b4a05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/783702d81225b0b0f83db4f739bba82552f7c64c7e2b1c4dba2406e25e83ac9ec645599e0dd4f72598a47abec3d93a8d7ab391be55760a50023f3b6a364b3293", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19a044a221870c6ab8053c066fe463c38c49e1cf985c0fd5d4f1fb584a8b6330d4961a32cc3ec35cb4fc7d0e463770f27272595ba169d5bcd681181eba61b6dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 08:47:12.175287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:47:12.175653) ========= 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.XERcr2VNkF/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.65wZrS5GCs/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005056 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:47:12.226025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 08:47:12.226754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 08:47:12.227433) ========= ========= Total master_lag: 0.19 =========