builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0307 starttime: 1472226201.16 results: success (0) buildid: 20160826062517 builduid: 950795c823814dcaae95dce96cf7b3d8 revision: 717ef7ea17e82c6fe24fed6fe89a532dcdb28a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.160258) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.160767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.161077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.186902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.187323) ========= 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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-26 08:43:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.2M=0.001s 2016-08-26 08:43:21 (17.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.396234 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.606806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.607137) ========= 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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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.026410 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:21.655824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 08:43:21.656193) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 717ef7ea17e82c6fe24fed6fe89a532dcdb28a19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 717ef7ea17e82c6fe24fed6fe89a532dcdb28a19 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kCgrYWXUQY/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.cXcTAp7zvK/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-26 08:43:21,741 truncating revision to first 12 chars 2016-08-26 08:43:21,741 Setting DEBUG logging. 2016-08-26 08:43:21,741 attempt 1/10 2016-08-26 08:43:21,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/717ef7ea17e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 08:43:22,679 unpacking tar archive at: mozilla-central-717ef7ea17e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 08:43:22.875929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:22.876271) ========= script_repo_revision: 717ef7ea17e82c6fe24fed6fe89a532dcdb28a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:22.876692) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:22.876977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 08:43:22.895924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-08-26 08:43:22.896318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kCgrYWXUQY/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.cXcTAp7zvK/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:43:23 INFO - MultiFileLogger online at 20160826 08:43:23 in /builds/slave/test 08:43:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:43:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:23 INFO - {'append_to_log': False, 08:43:23 INFO - 'base_work_dir': '/builds/slave/test', 08:43:23 INFO - 'blob_upload_branch': 'Firefox', 08:43:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:23 INFO - 'branch': 'Firefox', 08:43:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:23 INFO - 'config_files': ('talos/mac_config.py',), 08:43:23 INFO - 'default_actions': ('clobber', 08:43:23 INFO - 'read-buildbot-config', 08:43:23 INFO - 'download-and-extract', 08:43:23 INFO - 'populate-webroot', 08:43:23 INFO - 'create-virtualenv', 08:43:23 INFO - 'install', 08:43:23 INFO - 'run-tests'), 08:43:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:23 INFO - 'download_minidump_stackwalk': True, 08:43:23 INFO - 'download_symbols': 'ondemand', 08:43:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:23 INFO - 'installer_path': 'installer.exe', 08:43:23 INFO - 'log_level': 'info', 08:43:23 INFO - 'log_name': 'talos', 08:43:23 INFO - 'log_to_console': True, 08:43:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:43:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:43:23 INFO - 'opt_config_files': (), 08:43:23 INFO - 'pip_index': False, 08:43:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:23 INFO - 'cmd': ('bash', 08:43:23 INFO - '-c', 08:43:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:23 INFO - 'enabled': True, 08:43:23 INFO - 'halt_on_failure': False, 08:43:23 INFO - 'name': 'check_screen_resolution'},), 08:43:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:23 INFO - 'cmd': ('bash', 08:43:23 INFO - '-c', 08:43:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:23 INFO - 'enabled': True, 08:43:23 INFO - 'halt_on_failure': False, 08:43:23 INFO - 'name': 'check_screen_resolution'},), 08:43:23 INFO - 'run_cmd_checks_enabled': True, 08:43:23 INFO - 'sps_profile': False, 08:43:23 INFO - 'sps_profile_interval': 0, 08:43:23 INFO - 'suite': 'dromaeojs-e10s', 08:43:23 INFO - 'system_bits': '32', 08:43:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:23 INFO - 'title': 't-yosemite-r7-0307', 08:43:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:23 INFO - 'use_talos_json': True, 08:43:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:23 INFO - 'work_dir': 'build'} 08:43:23 INFO - [mozharness: 2016-08-26 15:43:23.093119Z] Running clobber step. 08:43:23 INFO - Running pre-action listener: _resource_record_pre_action 08:43:23 INFO - Running main action method: clobber 08:43:23 INFO - rmtree: /builds/slave/test/build 08:43:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:25 INFO - Running post-action listener: _resource_record_post_action 08:43:25 INFO - [mozharness: 2016-08-26 15:43:25.268155Z] Finished clobber step (success) 08:43:25 INFO - [mozharness: 2016-08-26 15:43:25.268537Z] Running read-buildbot-config step. 08:43:25 INFO - Running pre-action listener: _resource_record_pre_action 08:43:25 INFO - Running main action method: read_buildbot_config 08:43:25 INFO - Using buildbot properties: 08:43:25 INFO - { 08:43:25 INFO - "project": "", 08:43:25 INFO - "product": "firefox", 08:43:25 INFO - "script_repo_revision": "production", 08:43:25 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:43:25 INFO - "repository": "", 08:43:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:43:25 INFO - "buildid": "20160826062517", 08:43:25 INFO - "pgo_build": "False", 08:43:25 INFO - "basedir": "/builds/slave/test", 08:43:25 INFO - "buildnumber": 105, 08:43:25 INFO - "slavename": "t-yosemite-r7-0307", 08:43:25 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:43:25 INFO - "platform": "yosemite_r7", 08:43:25 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:43:25 INFO - "branch": "mozilla-central", 08:43:25 INFO - "repo_path": "mozilla-central", 08:43:25 INFO - "revision": "717ef7ea17e82c6fe24fed6fe89a532dcdb28a19", 08:43:25 INFO - "stage_platform": "macosx64", 08:43:25 INFO - "builduid": "950795c823814dcaae95dce96cf7b3d8", 08:43:25 INFO - "slavebuilddir": "test" 08:43:25 INFO - } 08:43:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:43:25 INFO - Running post-action listener: _resource_record_post_action 08:43:25 INFO - [mozharness: 2016-08-26 15:43:25.273429Z] Finished read-buildbot-config step (success) 08:43:25 INFO - [mozharness: 2016-08-26 15:43:25.273583Z] Running download-and-extract step. 08:43:25 INFO - Running pre-action listener: _resource_record_pre_action 08:43:25 INFO - Running main action method: download_and_extract 08:43:25 INFO - mkdir: /builds/slave/test/build/tests 08:43:25 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:43:25 INFO - trying https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:43:25 INFO - Downloading https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:43:26 INFO - Downloaded 1199 bytes. 08:43:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:43:26 INFO - Using the following test package requirements: 08:43:26 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:43:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:43:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:43:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'jsshell-mac.zip'], 08:43:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:43:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:43:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:43:26 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:43:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:43:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:43:26 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:43:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:43: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:43:26 INFO - trying https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:43:26 INFO - Downloading https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:43:27 INFO - Downloaded 16367248 bytes. 08:43:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:43:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:43:34 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:43:34 INFO - trying https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:43:34 INFO - Downloading https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:43:35 INFO - Downloaded 16367248 bytes. 08:43:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:43: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:43:42 INFO - trying https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:43:42 INFO - Downloading https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:43:42 INFO - Downloaded 14413998 bytes. 08:43:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:43 INFO - trying https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:43:43 INFO - Downloading https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:43:46 INFO - Downloaded 111823203 bytes. 08:43:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:43:46 INFO - mkdir: /builds/slave/test/properties 08:43:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:46 INFO - Contents: 08:43:46 INFO - build_url:https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:43:46 INFO - Running post-action listener: _resource_record_post_action 08:43:46 INFO - Running post-action listener: set_extra_try_arguments 08:43:46 INFO - [mozharness: 2016-08-26 15:43:46.787548Z] Finished download-and-extract step (success) 08:43:46 INFO - [mozharness: 2016-08-26 15:43:46.787710Z] Running populate-webroot step. 08:43:46 INFO - Running pre-action listener: _resource_record_pre_action 08:43:46 INFO - Running main action method: populate_webroot 08:43:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:46 INFO - '--tppagecycles', 08:43:46 INFO - '7'], 08:43:46 INFO - 'tests': ['tsvgm']}}, 08:43:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['damp', 'tps']}, 08:43:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'tests': ['damp', 'tps']}, 08:43:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['dromaeo_dom']}, 08:43:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['basic_compositor_video']}, 08:43:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['a11yr', 08:43:46 INFO - 'ts_paint', 08:43:46 INFO - 'tpaint', 08:43:46 INFO - 'sessionrestore', 08:43:46 INFO - 'sessionrestore_no_auto_restore', 08:43:46 INFO - 'tabpaint']}, 08:43:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:46 INFO - 'ts_paint', 08:43:46 INFO - 'tpaint', 08:43:46 INFO - 'sessionrestore', 08:43:46 INFO - 'sessionrestore_no_auto_restore', 08:43:46 INFO - 'tabpaint']}, 08:43:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:46 INFO - 'ts_paint', 08:43:46 INFO - 'tpaint', 08:43:46 INFO - 'sessionrestore', 08:43:46 INFO - 'sessionrestore_no_auto_restore', 08:43:46 INFO - 'tabpaint']}, 08:43:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:46 INFO - 'ts_paint', 08:43:46 INFO - 'tpaint', 08:43:46 INFO - 'sessionrestore', 08:43:46 INFO - 'sessionrestore_no_auto_restore', 08:43:46 INFO - 'tabpaint']}, 08:43:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['a11yr', 08:43:46 INFO - 'ts_paint', 08:43:46 INFO - 'tpaint', 08:43:46 INFO - 'sessionrestore', 08:43:46 INFO - 'sessionrestore_no_auto_restore', 08:43:46 INFO - 'tabpaint']}, 08:43:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['a11yr', 08:43:46 INFO - 'ts_paint', 08:43:46 INFO - 'tpaint', 08:43:46 INFO - 'sessionrestore', 08:43:46 INFO - 'sessionrestore_no_auto_restore', 08:43:46 INFO - 'tabpaint']}, 08:43:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['tsvgx', 08:43:46 INFO - 'tsvgr_opacity', 08:43:46 INFO - 'tart', 08:43:46 INFO - 'tscrollx', 08:43:46 INFO - 'cart']}, 08:43:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:46 INFO - 'tsvgr_opacity', 08:43:46 INFO - 'tart', 08:43:46 INFO - 'tscrollx', 08:43:46 INFO - 'cart']}, 08:43:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'talos_options': ['--disable-e10s'], 08:43:46 INFO - 'tests': ['tp5o']}, 08:43:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'tests': ['tp5o']}, 08:43:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'talos_options': ['--disable-e10s', 08:43:46 INFO - '--xperf_path', 08:43:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:46 INFO - 'tests': ['tp5n']}, 08:43:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:46 INFO - 'talos_options': ['--xperf_path', 08:43:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:46 INFO - 'tests': ['tp5n']}}, 08:43:46 INFO - 'talos.zip': {'path': '', 08:43:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:46 INFO - Running post-action listener: _resource_record_post_action 08:43:46 INFO - [mozharness: 2016-08-26 15:43:46.806418Z] Finished populate-webroot step (success) 08:43:46 INFO - [mozharness: 2016-08-26 15:43:46.806510Z] Running create-virtualenv step. 08:43:46 INFO - Running pre-action listener: _resource_record_pre_action 08:43:46 INFO - Running main action method: create_virtualenv 08:43:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:46 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:43:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:46 INFO - Using real prefix '/tools/python27' 08:43:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:50 INFO - Installing pip.................done. 08:43:50 INFO - Return code: 0 08:43:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:43:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:43:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:50 INFO - 'HOME': '/Users/cltbld', 08:43:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:50 INFO - 'LOGNAME': 'cltbld', 08:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:50 INFO - 'MOZ_NO_REMOTE': '1', 08:43:50 INFO - 'NO_EM_RESTART': '1', 08:43:50 INFO - 'PAGER': '/bin/cat', 08:43:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:50 INFO - 'PWD': '/builds/slave/test', 08:43:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:50 INFO - 'SHELL': '/bin/bash', 08:43:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:43:50 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:43:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:50 INFO - 'USER': 'cltbld', 08:43:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:50 INFO - 'XPC_FLAGS': '0x0', 08:43:50 INFO - 'XPC_SERVICE_NAME': '0', 08:43:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:50 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:43:50 INFO - Cleaning up... 08:43:50 INFO - Return code: 0 08:43:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:43:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:43:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:50 INFO - 'HOME': '/Users/cltbld', 08:43:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:50 INFO - 'LOGNAME': 'cltbld', 08:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:50 INFO - 'MOZ_NO_REMOTE': '1', 08:43:50 INFO - 'NO_EM_RESTART': '1', 08:43:50 INFO - 'PAGER': '/bin/cat', 08:43:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:50 INFO - 'PWD': '/builds/slave/test', 08:43:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:50 INFO - 'SHELL': '/bin/bash', 08:43:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:43:50 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:43:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:50 INFO - 'USER': 'cltbld', 08:43:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:50 INFO - 'XPC_FLAGS': '0x0', 08:43:50 INFO - 'XPC_SERVICE_NAME': '0', 08:43:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:51 INFO - Downloading/unpacking psutil>=3.1.1 08:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:54 INFO - Installing collected packages: psutil 08:43:54 INFO - Running setup.py install for psutil 08:43:54 INFO - building 'psutil._psutil_osx' extension 08:43:54 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:43:54 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:43:55 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:43:55 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:43:55 INFO - building 'psutil._psutil_posix' extension 08:43:55 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:43:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:43:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:43:55 INFO - ^ 08:43:55 INFO - 1 warning generated. 08:43:55 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:43:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:55 INFO - Successfully installed psutil 08:43:55 INFO - Cleaning up... 08:43:55 INFO - Return code: 0 08:43:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:55 INFO - 'HOME': '/Users/cltbld', 08:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:55 INFO - 'LOGNAME': 'cltbld', 08:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:55 INFO - 'MOZ_NO_REMOTE': '1', 08:43:55 INFO - 'NO_EM_RESTART': '1', 08:43:55 INFO - 'PAGER': '/bin/cat', 08:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:55 INFO - 'PWD': '/builds/slave/test', 08:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:55 INFO - 'SHELL': '/bin/bash', 08:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:43:55 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:55 INFO - 'USER': 'cltbld', 08:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:55 INFO - 'XPC_FLAGS': '0x0', 08:43:55 INFO - 'XPC_SERVICE_NAME': '0', 08:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:58 INFO - Installing collected packages: mozsystemmonitor 08:43:58 INFO - Running setup.py install for mozsystemmonitor 08:43:58 INFO - Successfully installed mozsystemmonitor 08:43:58 INFO - Cleaning up... 08:43:58 INFO - Return code: 0 08:43:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:58 INFO - 'HOME': '/Users/cltbld', 08:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:58 INFO - 'LOGNAME': 'cltbld', 08:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:58 INFO - 'MOZ_NO_REMOTE': '1', 08:43:58 INFO - 'NO_EM_RESTART': '1', 08:43:58 INFO - 'PAGER': '/bin/cat', 08:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:58 INFO - 'PWD': '/builds/slave/test', 08:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:58 INFO - 'SHELL': '/bin/bash', 08:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:43:58 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:58 INFO - 'USER': 'cltbld', 08:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:58 INFO - 'XPC_FLAGS': '0x0', 08:43:58 INFO - 'XPC_SERVICE_NAME': '0', 08:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:01 INFO - warning: no files found matching '*.txt' 08:44:01 INFO - no previously-included directories found matching 'build' 08:44:01 INFO - no previously-included directories found matching 'dist' 08:44:01 INFO - no previously-included directories found matching '.git*' 08:44:01 INFO - Installing collected packages: jsonschema, functools32 08:44:01 INFO - Running setup.py install for functools32 08:44:01 INFO - warning: no files found matching '*.txt' 08:44:01 INFO - no previously-included directories found matching 'build' 08:44:01 INFO - no previously-included directories found matching 'dist' 08:44:01 INFO - no previously-included directories found matching '.git*' 08:44:01 INFO - Successfully installed jsonschema functools32 08:44:01 INFO - Cleaning up... 08:44:01 INFO - Return code: 0 08:44:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:44:01 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:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:01 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:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:01 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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:44:01 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:44:01 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:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:01 INFO - 'HOME': '/Users/cltbld', 08:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:01 INFO - 'LOGNAME': 'cltbld', 08:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:01 INFO - 'MOZ_NO_REMOTE': '1', 08:44:01 INFO - 'NO_EM_RESTART': '1', 08:44:01 INFO - 'PAGER': '/bin/cat', 08:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:01 INFO - 'PWD': '/builds/slave/test', 08:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:01 INFO - 'SHELL': '/bin/bash', 08:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:01 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:01 INFO - 'USER': 'cltbld', 08:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:01 INFO - 'XPC_FLAGS': '0x0', 08:44:01 INFO - 'XPC_SERVICE_NAME': '0', 08:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:44:02 INFO - Cleaning up... 08:44:02 INFO - Return code: 0 08:44:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:02 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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:44:02 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:44:02 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:44:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:02 INFO - 'HOME': '/Users/cltbld', 08:44:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:02 INFO - 'LOGNAME': 'cltbld', 08:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:02 INFO - 'MOZ_NO_REMOTE': '1', 08:44:02 INFO - 'NO_EM_RESTART': '1', 08:44:02 INFO - 'PAGER': '/bin/cat', 08:44:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:02 INFO - 'PWD': '/builds/slave/test', 08:44:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:02 INFO - 'SHELL': '/bin/bash', 08:44:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:02 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:02 INFO - 'USER': 'cltbld', 08:44:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:02 INFO - 'XPC_FLAGS': '0x0', 08:44:02 INFO - 'XPC_SERVICE_NAME': '0', 08:44:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:05 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:44:05 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:44:05 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:44:05 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:44:05 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:44:05 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:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:05 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:44:05 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:44:05 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:44:05 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:44:05 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:44:05 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:44:06 INFO - Downloading docopt-0.6.1.tar.gz 08:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:06 INFO - Running setup.py install for blobuploader 08:44:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:06 INFO - Running setup.py install for requests 08:44:06 INFO - Running setup.py install for docopt 08:44:06 INFO - Successfully installed blobuploader requests docopt 08:44:06 INFO - Cleaning up... 08:44:07 INFO - Return code: 0 08:44:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:07 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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:44:07 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:44:07 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:44:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:07 INFO - 'HOME': '/Users/cltbld', 08:44:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:07 INFO - 'LOGNAME': 'cltbld', 08:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:07 INFO - 'MOZ_NO_REMOTE': '1', 08:44:07 INFO - 'NO_EM_RESTART': '1', 08:44:07 INFO - 'PAGER': '/bin/cat', 08:44:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:07 INFO - 'PWD': '/builds/slave/test', 08:44:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:07 INFO - 'SHELL': '/bin/bash', 08:44:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:07 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:07 INFO - 'USER': 'cltbld', 08:44:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:07 INFO - 'XPC_FLAGS': '0x0', 08:44:07 INFO - 'XPC_SERVICE_NAME': '0', 08:44:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-WLWDlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-4xZEex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-RYsLTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-m21eZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-CXhK6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-xIWrtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:07 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-zLdB9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-BkifJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-RLoDOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-d6uoxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-laNHt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-9Fg7X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-EP9orw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-kWNC1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-vr6h2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:08 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-mRmQrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:09 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-uvk3WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:09 INFO - Running setup.py install for manifestparser 08:44:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:09 INFO - Running setup.py install for mozcrash 08:44:09 INFO - Running setup.py install for mozdebug 08:44:09 INFO - Running setup.py install for mozdevice 08:44:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:09 INFO - Running setup.py install for mozfile 08:44:09 INFO - Running setup.py install for mozhttpd 08:44:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Running setup.py install for mozinfo 08:44:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Running setup.py install for mozInstall 08:44:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Running setup.py install for mozleak 08:44:10 INFO - Running setup.py install for mozlog 08:44:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Running setup.py install for moznetwork 08:44:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:10 INFO - Running setup.py install for mozprocess 08:44:10 INFO - Running setup.py install for mozprofile 08:44:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:11 INFO - Running setup.py install for mozrunner 08:44:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:11 INFO - Running setup.py install for mozscreenshot 08:44:11 INFO - Running setup.py install for moztest 08:44:11 INFO - Running setup.py install for mozversion 08:44:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:11 INFO - Cleaning up... 08:44:11 INFO - Return code: 0 08:44:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:11 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:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:11 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:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:11 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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:44:11 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:44:11 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:44:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:11 INFO - 'HOME': '/Users/cltbld', 08:44:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:11 INFO - 'LOGNAME': 'cltbld', 08:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:11 INFO - 'MOZ_NO_REMOTE': '1', 08:44:11 INFO - 'NO_EM_RESTART': '1', 08:44:11 INFO - 'PAGER': '/bin/cat', 08:44:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:11 INFO - 'PWD': '/builds/slave/test', 08:44:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:11 INFO - 'SHELL': '/bin/bash', 08:44:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:11 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:11 INFO - 'USER': 'cltbld', 08:44:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:11 INFO - 'XPC_FLAGS': '0x0', 08:44:11 INFO - 'XPC_SERVICE_NAME': '0', 08:44:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-9R_TiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-LPYYRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-yfyBVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-wmnUgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-NXuawl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-3IyQCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-OoZXwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-U84SNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-493jGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:12 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:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:12 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-4NlaCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-K_qHOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:13 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:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-iUBI7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-bTY_pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:13 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:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-G9o6Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-cZhHbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:13 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:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-pMeHKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:13 INFO - Running setup.py (path:/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/pip-DJ6uPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:13 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:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:44:13 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:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:44:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:13 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:44:13 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:44:13 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:44:13 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:44:13 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:44:13 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:44:16 INFO - Downloading blessings-1.6.tar.gz 08:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:16 INFO - Installing collected packages: blessings 08:44:16 INFO - Running setup.py install for blessings 08:44:16 INFO - Successfully installed blessings 08:44:16 INFO - Cleaning up... 08:44:16 INFO - Return code: 0 08:44:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:16 INFO - Reading from file tmpfile_stdout 08:44:16 INFO - Current package versions: 08:44:16 INFO - blessings == 1.6 08:44:16 INFO - blobuploader == 1.2.4 08:44:16 INFO - docopt == 0.6.1 08:44:16 INFO - functools32 == 3.2.3-2 08:44:16 INFO - jsonschema == 2.5.1 08:44:16 INFO - manifestparser == 1.1 08:44:16 INFO - mozInstall == 1.12 08:44:16 INFO - mozcrash == 0.17 08:44:16 INFO - mozdebug == 0.1 08:44:16 INFO - mozdevice == 0.48 08:44:16 INFO - mozfile == 1.2 08:44:16 INFO - mozhttpd == 0.7 08:44:16 INFO - mozinfo == 0.9 08:44:16 INFO - mozleak == 0.1 08:44:16 INFO - mozlog == 3.3 08:44:16 INFO - moznetwork == 0.27 08:44:16 INFO - mozprocess == 0.23 08:44:16 INFO - mozprofile == 0.28 08:44:16 INFO - mozrunner == 6.12 08:44:16 INFO - mozscreenshot == 0.1 08:44:16 INFO - mozsystemmonitor == 0.3 08:44:16 INFO - moztest == 0.7 08:44:16 INFO - mozversion == 1.4 08:44:16 INFO - psutil == 3.1.1 08:44:16 INFO - requests == 1.2.3 08:44:16 INFO - wsgiref == 0.1.2 08:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:16 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:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:16 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:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:16 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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:44:16 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:44:16 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:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:16 INFO - 'HOME': '/Users/cltbld', 08:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:16 INFO - 'LOGNAME': 'cltbld', 08:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:16 INFO - 'MOZ_NO_REMOTE': '1', 08:44:16 INFO - 'NO_EM_RESTART': '1', 08:44:16 INFO - 'PAGER': '/bin/cat', 08:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:16 INFO - 'PWD': '/builds/slave/test', 08:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:16 INFO - 'SHELL': '/bin/bash', 08:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:16 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:16 INFO - 'USER': 'cltbld', 08:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:16 INFO - 'XPC_FLAGS': '0x0', 08:44:16 INFO - 'XPC_SERVICE_NAME': '0', 08:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 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:44:17 INFO - Cleaning up... 08:44:17 INFO - Return code: 0 08:44:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:17 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 0x1025f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102687618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7015ae2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, '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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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:44:17 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:44:17 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:44:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:17 INFO - 'HOME': '/Users/cltbld', 08:44:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:17 INFO - 'LOGNAME': 'cltbld', 08:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:17 INFO - 'MOZ_NO_REMOTE': '1', 08:44:17 INFO - 'NO_EM_RESTART': '1', 08:44:17 INFO - 'PAGER': '/bin/cat', 08:44:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:17 INFO - 'PWD': '/builds/slave/test', 08:44:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:17 INFO - 'SHELL': '/bin/bash', 08:44:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:17 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:17 INFO - 'USER': 'cltbld', 08:44:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:17 INFO - 'XPC_FLAGS': '0x0', 08:44:17 INFO - 'XPC_SERVICE_NAME': '0', 08:44:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:44:17 INFO - Cleaning up... 08:44:17 INFO - Return code: 0 08:44:17 INFO - Running post-action listener: _resource_record_post_action 08:44:17 INFO - Running post-action listener: _start_resource_monitoring 08:44:17 INFO - Starting resource monitoring. 08:44:17 INFO - [mozharness: 2016-08-26 15:44:17.427961Z] Finished create-virtualenv step (success) 08:44:17 INFO - [mozharness: 2016-08-26 15:44:17.428985Z] Running install step. 08:44:17 INFO - Running pre-action listener: _resource_record_pre_action 08:44:17 INFO - Running main action method: install 08:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:17 INFO - Reading from file tmpfile_stdout 08:44:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:17 INFO - Reading from file tmpfile_stdout 08:44:17 INFO - Output received: 08:44:17 INFO - Usage: mozinstall [options] installer 08:44:17 INFO - Options: 08:44:17 INFO - -h, --help show this help message and exit 08:44:17 INFO - -d DEST, --destination=DEST 08:44:17 INFO - Directory to install application into. [default: 08:44:17 INFO - "/builds/slave/test"] 08:44:17 INFO - --app=APP Application being installed. [default: firefox] 08:44:17 INFO - mkdir: /builds/slave/test/build/application 08:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:44:51 INFO - Reading from file tmpfile_stdout 08:44:51 INFO - Output received: 08:44:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:44:51 INFO - Running post-action listener: _resource_record_post_action 08:44:51 INFO - [mozharness: 2016-08-26 15:44:51.981291Z] Finished install step (success) 08:44:51 INFO - [mozharness: 2016-08-26 15:44:51.981443Z] Running run-tests step. 08:44:51 INFO - Running pre-action listener: _resource_record_pre_action 08:44:51 INFO - Running main action method: run_tests 08:44:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:51 INFO - 2016-08-26 08:44:51.995 screenresolution[1633:7423] starting screenresolution argv=screenresolution get 08:44:51 INFO - 2016-08-26 08:44:51.998 screenresolution[1633:7423] Display 0: 1600x1200x32@60 08:44:52 INFO - 2016-08-26 08:44:52.004 screenresolution[1634:7425] starting screenresolution argv=screenresolution list 08:44:52 INFO - Available Modes on Display 0 08:44:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:52 INFO - Intel Iris: 08:44:52 INFO - Chipset Model: Intel Iris 08:44:52 INFO - Type: GPU 08:44:52 INFO - Bus: Built-In 08:44:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:52 INFO - Vendor: Intel (0x8086) 08:44:52 INFO - Device ID: 0x0a2e 08:44:52 INFO - Revision ID: 0x0009 08:44:52 INFO - Displays: 08:44:52 INFO - Display: 08:44:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:52 INFO - Display Serial Number: 1600x1200 60 08:44:52 INFO - Main Display: Yes 08:44:52 INFO - Mirror: Off 08:44:52 INFO - Online: Yes 08:44:52 INFO - Rotation: Supported 08:44:52 INFO - Return code: 0 08:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:52 INFO - Python 2.7.3 08:44:52 INFO - Return code: 0 08:44:52 INFO - grabbing minidump binary from tooltool 08:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:52 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 0x102556d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10254eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:52 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:44:52 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:44:52 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:44:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:52 INFO - Return code: 0 08:44:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:44:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:44:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0307 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:44:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kCgrYWXUQY/Render', 08:44:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:52 INFO - 'HOME': '/Users/cltbld', 08:44:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:52 INFO - 'LOGNAME': 'cltbld', 08:44:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:52 INFO - 'MOZ_NO_REMOTE': '1', 08:44:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:52 INFO - 'NO_EM_RESTART': '1', 08:44:52 INFO - 'PAGER': '/bin/cat', 08:44:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:52 INFO - 'PWD': '/builds/slave/test', 08:44:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:52 INFO - 'SHELL': '/bin/bash', 08:44:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cXcTAp7zvK/Listeners', 08:44:52 INFO - 'TMPDIR': '/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/', 08:44:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:52 INFO - 'USER': 'cltbld', 08:44:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:52 INFO - 'XPC_FLAGS': '0x0', 08:44:52 INFO - 'XPC_SERVICE_NAME': '0', 08:44:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0307', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:44:52 INFO - mozversion application_buildid: 20160826062517 08:44:52 INFO - mozversion application_changeset: 717ef7ea17e82c6fe24fed6fe89a532dcdb28a19 08:44:52 INFO - mozversion application_display_name: Nightly 08:44:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:52 INFO - mozversion application_name: Firefox 08:44:52 INFO - mozversion application_remotingname: firefox 08:44:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:44:52 INFO - mozversion application_vendor: Mozilla 08:44:52 INFO - mozversion application_version: 51.0a1 08:44:52 INFO - mozversion platform_buildid: 20160826062517 08:44:52 INFO - mozversion platform_changeset: 717ef7ea17e82c6fe24fed6fe89a532dcdb28a19 08:44:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:44:52 INFO - mozversion platform_version: 51.0a1 08:44:52 INFO - using testdate: 1472226292 08:44:52 INFO - actual date: 1472226292 08:44:52 INFO - starting webserver on 'localhost:49262' 08:44:52 INFO - SUITE-START | Running 2 tests 08:44:52 INFO - TEST-START | dromaeo_css 08:44:52 INFO - operating with platform_type : mac_ 08:44:52 INFO - Initialising browser for dromaeo_css test... 08:44:52 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmp_k8Fw1/profile http://localhost:49262/getInfo.html) 08:44:55 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 08:44:55 INFO - PROCESS | 1644 | colorDepth:24 08:44:55 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 08:44:55 INFO - PROCESS | 1644 | __metrics 08:44:55 ERROR - PROCESS | 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 08:44:56 INFO - TEST-INFO | 1644: exit 0 08:44:56 INFO - Browser initialized. 08:44:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:56 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmp_k8Fw1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:08 INFO - PROCESS | 1647 | RSS: Main: 244232192 08:45:08 INFO - PROCESS | 1647 | 08:45:57 INFO - PROCESS | 1647 | 1472226357983 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:48:09 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 08:48:11 INFO - PROCESS | 1647 | RSS: Main: 264159232 08:48:11 INFO - PROCESS | 1647 | 08:51:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 08:51:14 INFO - PROCESS | 1647 | RSS: Main: 271966208 08:51:14 INFO - PROCESS | 1647 | 08:54:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 08:54:16 INFO - PROCESS | 1647 | RSS: Main: 274518016 08:54:16 INFO - PROCESS | 1647 | 08:57:18 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 08:57:19 INFO - PROCESS | 1647 | RSS: Main: 270839808 08:57:19 INFO - PROCESS | 1647 | 09:00:22 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 09:00:22 INFO - PROCESS | 1647 | RSS: Main: 277065728 09:00:22 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 09:03:26 INFO - PROCESS | 1647 | RSS: Main: 279887872 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | __start_tp_report 09:03:26 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 09:03:26 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 09:03:26 INFO - PROCESS | 1647 | |i|pagename|runs| 09:03:26 INFO - PROCESS | 1647 | |0;dojo.html;3432.365012472694;3438.174838038871;3464.497647841063;3471.4098603237453;3483.3729928612856;5822.126680997852;5833.5916485845955;5874.471297583216;5876.2948446186465;5937.881242375161;4418.491873434548;5605.1872478490695;5893.204417403649;5945.583809133363;5997.580169388145;5239.685618862871;5307.73461326934;5386.91919621204;5389.191621256823;5394.433584473632;5174.327337446127;5270.367555893298;5326.92009619856;5357.249985002103;5399.325084364455;5304.38999515053;5317.813876514323;5321;5375.301210842605;5421.1326187810155;5310.814121505768;5323.441038690959;5332.280142180794;5339.012282727708;5403.972980135113;5142.408623008365;5253.553447956928;5291.444398338158;5296.5762738981175;5312.4687531246955;4680.531946805327;5677.545796336283;5906.5570082244;5914.349421563625;6005.219321488178;6176.536759743038;6228.018611324244;6242.344553821828;6262.935300998795;6273.529485288622;6118.162361256311;6239.438450539473;6268.279147898004;6286.559940804145;6295.118683384329;5928.288605367384;5965.791197308074;5998.970005149947;6016.308124565688;6062.514998800086;6373.936260637334;6446.806595802133;6458.806235812933;6463.612183269019;6468.06213099098;6131.50947924165;6257.78097766576;6264.780732674426;6273.686315684197;6277.811665650038;6188.44304012641;6214.658193799294;6230.439260466489;6283.6858157091965;6299.716512756937;6183.783567575203;6280.152179455715;6282.4974002079725;6286.057091436322;6291.591046582049;5161.993411284839;6202.751889924352;6275.748970041239;6289.496840252768;6309.148264984168;4979.153543897546;5028.969061342416;5030.094582975026;5041.899162016739;5083.135866902636;3464.86140554375;3602.765820221677;3711.6473934976134;4269;4524.751138687404;5658.264425624642;5968.403159683997;5987.970060149672;6030.698465076816;6047.183630209954;6169.691515424211;6170.976689524024;6187.628742275388;6271.27880293763;6276.121343011982;5914.053751399755;5935.376785437467;5943.673097979567;5960.195373624592;5978.4021597839865;5425.430329815392;5464.371597266286;5465;5477.3427188737605;5495.230667706524;6322.209723784527;6394.328595497405;6436.549441539048;6459.192600924885;6565.704543295467;6280.591761535486;6307.90538141919;6313.684315784284;6315;6320.051992201023;6496.382843629847;6533.575317604341;6559.508036897348;6576.605403675795;6577.835554111186;6117.035835319669;6219;6219.533534984985;6241.344658810941;6297.2128483939505;5397.8380648580605;6274.090256912631;6284.905726414199;6287.30839607652;6289.7169627365965;5689.374168841341;6188.907166392598;6268.9969604863;6275.937240627535;6289.371062893674;6123.234595675541;6153.384661533811;6182.381761823782;6195.907061393992;6252.249730032425;6007.429294217042;6055.364186760326;6114.510839132769;6140.109684095871;6142.570020098729;5050.949490505195;6139.26328840542;6183.0107182850525;6254.061890716429;6274.341194174546;6067.119193050168;6090.208272924491;6110.327863935053;6116.847078823065;6127.080937859357 09:03:26 INFO - PROCESS | 1647 | |1;ext.html;489.8456986049395;511.9718415487147;532.7309708597159;534.324080038751;569.5557465177163;37386.813065934664;39729.80135099324;39765.80702578924;39862.402063969064;39881;40987.18025639485;41379.3448212081;41493.58506414935;41602;41620.16759664805;9598.520073996307;9819.165370943478;9823.65617203398;9828.36115652484;9838.458884761336;7998.640061197231;9778.951105244463;9854.802903941916;9922;9941;9822;9878.950605246964;9885.505724713772;9897.703068907944;9947.353422027581;9515.762105947337;9827.066428689299;9858.704238872846;9876.851847222297;9914.652987145488;7443.925560744377;9768.658096966572;9769.169620582259;9799.706008819747;9806.460644664541;38976.80511597452;39088;39212.60787392118;39357.80321098376;39375.21249575021;3296.9602881979;3556.6443355664487;3657.963420365789;3870.748401353903;4349.913001739979;30932.536011959837;31577.368452630817;31944.840275798706;32050.19874503156;32126.678733212604;3225.3226822367096;3365.764396492222;3402.183475965775;3443.6900678939014;3457.2048428861503;307602;348007;373591;374193;376144;60322.698386507785;60372.09441858376;60747.69626151841;60816.08775868366;60930.39069609247;62278;62732.686336568026;62801.371986280465;62848.371516285166;62852.68573657194;16034.438794642365;16083.035017898963;16246.918765406097;16304.918475407547;16334;12603.936980315224;12642.620721378373;12642.873571264354;12671.936640316739;12705.745885082246;15313.923430382776;16642.417515386904;16675.91662041682;16684.416045438593;16812.327506899586;5530.944690553123;5617.494425501724;6555.901661475082;6594.9670251649395;6618.735250590019;848.779317377474;907.4872696926216;1038.981797838123;1056.6882769582837;1067.9252452328262;26956;30539.08382748521;30585.929492467658;30717.657181794555;30866.76532938702;1045.72288343589;1059.660908509285;1167.6205233299042;1168.7954607943575;1212.5210541836102;15434.845651543565;15872.888897777044;15943.760843587355;16207;16512.587185320463;688219;694390;698593;700721;700876;58795.706021470476;58999.11501327484;59081.40918590845;59452;59527;1302.6743314171458;1334.3461703765279;1352.5266156845025;1354.7290541891857;1356.1727346318935;25675.459472431714;26816.865915670296;27332.726672733814;28479.43041139207;30474.84762576173;52337;52875.47124528705;52942;52979.94040119099;52999;500638;505616;505898;506982;616463;26678.59982100309;26827.926882925247;26916.596251055857;26937.326566835203;27006;47035.764821175675;47453.288200676325;48105;48275.75862120667;48677.75661121672;38858.80570597129;39248;40036.19927601374;40716.59283407128;40768;38194.506933821875;39748.20503589854;40196;40977.85332200194;41188.58811411847;38327.80836095801;38924.80537597294;39270.214595708494;39465.802670986464;39635.80182099071;34734.826325868205;34979.12552186216;35941;35948.64051359453;36064.459033114;22859.788978902685;25986.740132598432;26444.338891527867;26594.86702566475;26983.73016269812 09:03:26 INFO - PROCESS | 1647 | |2;jquery.html;335.5252317970072;359.73559433816143;367.5846293688133;373.94203898395756;393.99531195451607;18052;20099.095540700666;20780.48048798779;21556.56886862264;21767.891160544175;18958.431247062577;19375.806241937575;20265.898670506627;21135.682964755542;21347.146114155454;5818.796342128037;5947.791827286046;6001.819945401623;6038.96980515099;6114.419130182648;4143.813528391214;5960.88078238435;6054.8183554493435;6056.061310496858;6097.420745029215;6372.107904893319;6655.866882662343;6736.932630673704;6761.898571521431;6776.085228494139;6628.426385793787;6678.098456708331;6729.05793188954;6760.8309792255095;6774.322567743236;5841.328247251536;5841.3282472515775;5845.269341332333;5846.239988801472;5858.12128180772;23823.49853265417;25196.496070078494;25814.74185258161;25856.353591160372;25935.22194334173;1834.1471215884678;1986.5927484865567;2194.7709282801684;2447.49826285611;2547.3631592101974;5654.74553645087;8042.798930026737;8395.538245396501;10176.16828970785;10443.738906527322;1830.6247219320007;1832.5876677747533;1925.5859990102194;1936.4093951344835;1937.9612407751765;98534;122074.16888746676;129865;130754;133122;9367.250619950388;11015.614453494089;11221.270617410006;11243.775124497464;11284.097272218203;11456.54173833054;14070.226137562327;14139.151650900978;14162.504312349018;14192.645183870485;6985.406240469617;8233.752987410388;8492.278156356655;8570.785730356667;8635.352348573882;8348.707795227137;8442.451240669337;8456.704015359433;8649.610767515476;8655.091215422415;3852.556955950102;4408.603225709701;4459.1973444779605;4474.619657329098;4485.618722408632;1544.90730556167;1868.168664944114;1934.3713293179774;1937.2347922570507;1939.3697048459308;801.3949468151508;820.7865954851662;841.2765022081005;912.7085174478171;1062.8512008318842;20654.793452065285;21375.251866184608;21466.24868129608;21485.462863428227;21581.89209053976;731.3271789953255;884.2351366068433;925.9166674999283;952.7903861150675;955.2358113509165;10752.354858708502;11153.996140347408;11248.831267530994;11250.381229032482;11268.042216411697;567170;590616;598224;599091;602795;135051;136998;139721.30139349238;140855;141369;953.5565961827783;954.3081266082035;964.8986856380119;969.3021024862088;974.055166488505;17747.556311092325;18376.173072211513;18606.976616286232;19120.852748835114;19375.709364359263;37502.81248593739;45457;55677.72161139168;57586.7120664394;58249.54376140461;74475.62762186154;74911;77016.61491692506;80993.3801323982;82169;7688;8016.358691304798;8215.917840821516;8248.556502612139;8389.244967952913;12026.518939242333;13182.670433239246;13322.933385333012;13506.257155856521;13522.729545409233;8676.440450067372;9177.449353038839;9460.621575136918;11617.941910290394;11777.470013849226;9535.666251681158;11229;11447.027002704863;11639.359835209145;11674.533018679498;10691.893081069089;11418.486168122621;11746.765064698488;11767.52929882795;11810.940945295219;8016.8797468036855;8129.065157506962;8156.551389673625;8188.344932405513;8239.546824924686;7393;7409.777706668809;7935.0874649413745;7961.482503637245;8571.657133714582 09:03:26 INFO - PROCESS | 1647 | |3;mootools.html;1423.864732850379;1500.0474698566413;1692.1708362902182;1797.2900704221825;1861.3857427049074;8044.959775201116;8566.271866891313;8714;9128.995810460843;9156.404833685805;8702;8910.287177025839;8928.776780580489;8932.776680582989;8937.061608531109;2386.4272574582105;2409.2170044735444;2411.6503107049557;2418.443757935676;2427.3324835670155;2374.536965291769;2400.4478969836946;2417.7098748150247;2421.806255499556;2425.2845410603827;2390.605550084234;2400.687910571632;2414.6860908082012;2418.830681852271;2423.0550085466684;2376.6791483149727;2390.760923907613;2398.8080953523677;2403.242978461779;2403.615421532555;2373.1456675596773;2380.4405964598304;2386.916457923982;2393.868337241451;2394.185976767907;8854.778630534223;8960.372773905829;8962.058983806672;8963.193312601832;8996.77508062297;5295.099833028395;5403.864903377408;5420.972895135538;5429.945700542983;5434.076207044812;3599.3341231872187;3716.2195938852874;3743.12036671382;3776.131489757344;3788.052986753312;1116.9888301117048;1134.6482590397004;1143.0741099709178;1153.6712037069478;1759.375421725282;11524.942375288154;11682.831716828248;11807.114466414967;11837.408129593487;11843.170978031541;4345.326474396474;4617.907641847211;4673;4698.718076915396;4716.080364328923;9074.001859795417;9149.176574108229;9162.129597688208;9163.679271225476;9174.357794954289;5293.417724050351;5303.15149576066;5303.310569625924;5308.628396012319;5312.601554883399;4289.335153051282;4820.6143508519235;4942.382202224722;4956.430010548761;4991.525805048587;3755.1738617504107;3821.617838216156;3885.2618002579984;3900.3759398496104;3918;1006.6929586476195;1175.0893057880212;1186.9762604747857;1190.6963724250434;1193.1230545549015;924.6856068936594;937.3485427627869;937.5312343828086;945.2532499325594;973.464594473037;4965.652404331662;5487.807926722546;6045.304789949212;6065.727042283108;6226.750929962841;434.50032462667554;435.3948012262957;438.31622668637027;444.36234004203425;458.5071048622744;3945.861894833667;4052;4071.918561628751;4176.331786914079;4185.727927684691;10447.805960748175;10884.782304353868;10895.182861285435;10906.5092070857;10909.18181136402;10813.945930270298;10826.404547749791;10832.945835270773;10836.187285953585;10857.077148442313;7994.440389172702;7995.480293780885;8290.544020078833;8322.958385208036;8334.374921880883;5840;5937.792177273947;6008.489278411384;6011.398860113954;6021.518278537619;7926.881096783668;8999.235065019546;9864.753381165528;10153.54309056109;10212.234082443698;8427.705030323908;10046.246531510313;10354.430506322225;10366.533505992098;10415.479226038819;6627.469802415699;6896.413804826646;7030.648467576703;7120.430365570845;7171.103612048494;8618.353623478139;8633;8664.220220180214;8679.17547832955;8690.304775618062;7593.430492712958;7697.461177717506;7796.961015195115;7820.3743700504965;7858.096318923397;7436.553806771611;7564.886526701994;7583.393328533593;7608.125065617303;7706.576138312446;7059.964700176466;7202.423806095395;7214.242504536948;7220.638968051681;7238.348548630648;4976.8755781105765;4982.928670335895;5078.847634570969;5142.1772516397195;5263.315768950012;3851.691864650877;5075;5143.0999575073465;5234.424213336606;5306.177542480922 09:03:26 INFO - PROCESS | 1647 | |4;prototype.html;296.9709955005904;304.47782053777775;308.86718710954295;310.44275525431846;316.32622514045096;4558.749268790223;5365.444021233842;5648.700798816275;5664.2636457260605;5692.9146062809095;5502.119660854264;5511.476409741068;5528.419515950827;5554.944450555503;5574.888502229963;3769.54765428149;4148.738937279175;4156.314208155651;4212.599803018708;4236.915261694764;4166.83332666693;4187.392828039932;4210.831421817767;4234.470691163605;4237.453329534713;3470.6008808986912;4170.39529268256;4182.051653584231;4200.222958752625;4241.791089539482;4028.8992775180564;4162.562930892243;4171.728837625545;4217.304144816102;4220.7256528325715;3052.5958059292752;3587.031501494608;3617.6382361763876;3629.7277704172293;3645.38028535147;5366.436524164985;5368.785248590052;5373.946260537384;5382.085045542267;5391.541718953894;3536.3104194682046;4631.3516107744945;4752.19416621685;4853.252828981564;4853.344798452199;5163.922541161848;5780.855478613026;5803.129530570448;5879.67661778602;5886.7939622113445;3996.9400458993136;4015.875554844619;4022.6379625833524;4038.6365227129404;4053.716239863211;5115.514026167545;5711.314642242957;5994.482317426691;6061.151438798572;6158.630482171039;3621.1713084891962;3780.8487660493274;4038.676905847525;4080.8571699990357;4103.610157035077;3592.694620957248;4070.900856768715;4155.252054630196;4172.207280616673;4177.373393990925;3981.5023122109737;4286.357046443059;4798.568128868418;4844.95155048452;4853.912817488514;5294.57643388528;5821.253623912809;5859.853503662443;5878.353381128072;5911.261092363455;1231.5566396097397;1410.5274732964572;1417.4471955937192;1425.308725268244;1433.4982756035304;805.295366554265;860.9870851937226;868.5700578213824;874.510274246424;896.2023798819056;5225.555827754683;5227.712475813867;5364.658835291178;5377.435369286169;5632.718364081861;5942.741758131882;6071.635701857903;6129.448349648553;6144.832481828438;6157.538184636171;5246.186841039645;5492.917606235909;5524.751386187631;5538.584606154554;5549.195366671891;2895.1604034830084;3078.1688943985;3167.334859679493;3194.584703988513;3223.5487031815564;5376.892462150735;5679.750454899915;6098.817035488943;6368.980963045983;6374.9681251594375;5674.801381951612;5688.431156884279;6011.549133814894;6145.4161854623735;6189.752409903644;5496.169472721552;6336.483251795205;6348.77779277723;6368.64972426521;6370.8088757337355;4733.414306207322;4877.805087624569;5172.793088276427;5220.728982892454;5850.736716847837;4863.051704917649;5050.671706339076;5403.945960540502;5606.6916319602815;5974.790882319098;5552.918604825531;5649.802256920988;6078.422549857756;6303.495720342454;6331.841703957438;3459.4983727359895;3668.358037343401;3899.9610003900734;4076.3477843544892;4085.22380747657;5316.069687804541;5530.225768392509;6060.393960603904;6073.240844894388;6084.847878803065;5154.891698284887;5167.250748641351;5675.4040825714355;5897.3807750185615;5939.2575928009;5556.472135147154;5775.249217601853;5803.970980145073;5823;5892.263467066617;5641.830745077655;5748.425157484218;5753.971230143822;5758;5761.683107428964;5324.733763311741;5490.286262785812;5523.834284971457;5778.942210578009;5811.767529298781;5398.54366263357;5401.4868587484125;5402.324709411324;5471.644343117685;5714.428557144252 09:03:26 INFO - PROCESS | 1647 | |5;yui.html;706.713780918728;717.8564287142573;720.6468830273166;770.8882212079249;818.341235305579;14828.184449855267;15845.89078764487;15883.682326353466;15884.920575397122;15903.68192636148;14451.494197703083;14616.269186540658;14627.122372657648;14632.268386580656;14634.48779292725;677.6543962579083;820.659426338069;848.5417874347876;853.9231469167773;860.8192279621287;854.5129276312505;854.7820305822007;855.5807654249435;859.9699010534632;860.4708104515709;920.5351297594706;923.833709932212;924.2005665099707;925.5927391947555;928;909.2544113826665;910.7905181808221;913.9771505712343;914.4193437167446;918.0452329577232;670.058567712365;680.884249677556;682.8668409660119;683.704380199524;684.0594182998377;10498.580056797718;13817.447302108005;14488.565343039725;14522.201278929655;14570.635734106627;14197.432102715879;14308.356123974447;14448.205348705817;14471.855281447157;14536.92731536346;11125.27685700435;11262.662120136409;11269;11417.257878237888;11654.125940554492;3784.4512545680723;3868.6324799144036;3874.8837534874;3948.2498325318097;4014.297497937849;99337;104455.47772261166;104507;113590.99999999917;115504.42247788707;11083.445827708581;11159.944200278947;11237.381943992996;11454.828177577343;11656.125790565571;22046.33860984173;22051.11795528161;22054.89725513718;22078.558428831333;22084.447888802908;7989.280964713087;8126.553039582762;8158.184181581794;8309;8324.417290789708;4484.170428470743;4571.405717256735;4595.954040459619;4738.64460165489;4743.976280118577;3382.475716263983;3453.9827300863335;3506.5441492605796;3511.648835116468;3521.084518025332;652.8204743695521;654.502578040683;655.0698008827381;670.9765158219438;677.2482544375739;572.9799457018985;605.479287812481;644.6486664767713;674.2145400608334;678.8574399376088;9201.125893040151;9365.62537498506;9451.763705907408;9662.323637345458;10056.892996447206;661.4278648968608;661.6948343026517;668.6217588906395;690.2786588015535;709.9964500177466;4296.892577685583;4334.1981733379425;4634.884127896829;4673.859784206479;4701.858944231679;167673;172915;174510;175376;182244;145286;147969.26015370068;149038;149436;152700;123284;128291;128799.35600322126;129338;130077.69922300846;8178.9591052046735;8418.326533877398;8495.362847786564;8723.040465548658;9021.323400745101;58863.41136588579;67643;68735.96896046663;68990;69566.65216673884;64781;91192;105564;105798.82603521907;107310.92689073322;12185.51257949672;12349.32078735678;12590.11869169186;13028.348582570645;13144.60566183016;13163.802542961672;13338.26639534796;13351.599452016066;13494.662633434242;13721.588352349445;12145.757084858431;12415.068869834618;12497;12515.499380024698;12872.22766634005;12556.754819181415;12595.118341715992;12731.108822382344;12804.423800928795;12869.163504372185;10305.58293753923;10648.935106489598;11872.168948173545;11942.820857687315;12180.147389682637;9597.9040209597;10103.949480252551;10245.897541024793;10332.845007324746;10526.421046842192;10425;10719;10734.570617175537;10857.294275872044;10902.50938707776 09:03:26 INFO - PROCESS | 1647 | __end_tp_report 09:03:26 INFO - PROCESS | 1647 | __start_cc_report 09:03:26 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,380 09:03:26 INFO - PROCESS | 1647 | __end_cc_report 09:03:26 INFO - PROCESS | 1647 | __startTimestamp1472227406312__endTimestamp 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | ------- Summary: start ------- 09:03:26 INFO - PROCESS | 1647 | Number of tests: 6 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5802.26 Median:6090.21 stddev:700.43 (11.5%) stddev-sans-first:677.46 09:03:26 INFO - PROCESS | 1647 | Values: 3432.4 3438.2 3464.5 3471.4 3483.4 5822.1 5833.6 5874.5 5876.3 5937.9 4418.5 5605.2 5893.2 5945.6 5997.6 5239.7 5307.7 5386.9 5389.2 5394.4 5174.3 5270.4 5326.9 5357.2 5399.3 5304.4 5317.8 5321.0 5375.3 5421.1 5310.8 5323.4 5332.3 5339.0 5404.0 5142.4 5253.6 5291.4 5296.6 5312.5 4680.5 5677.5 5906.6 5914.3 6005.2 6176.5 6228.0 6242.3 6262.9 6273.5 6118.2 6239.4 6268.3 6286.6 6295.1 5928.3 5965.8 5999.0 6016.3 6062.5 6373.9 6446.8 6458.8 6463.6 6468.1 6131.5 6257.8 6264.8 6273.7 6277.8 6188.4 6214.7 6230.4 6283.7 6299.7 6183.8 6280.2 6282.5 6286.1 6291.6 5162.0 6202.8 6275.7 6289.5 6309.1 4979.2 5029.0 5030.1 5041.9 5083.1 3464.9 3602.8 3711.6 4269.0 4524.8 5658.3 5968.4 5988.0 6030.7 6047.2 6169.7 6171.0 6187.6 6271.3 6276.1 5914.1 5935.4 5943.7 5960.2 5978.4 5425.4 5464.4 5465.0 5477.3 5495.2 6322.2 6394.3 6436.5 6459.2 6565.7 6280.6 6307.9 6313.7 6315.0 6320.1 6496.4 6533.6 6559.5 6576.6 6577.8 6117.0 6219.0 6219.5 6241.3 6297.2 5397.8 6274.1 6284.9 6287.3 6289.7 5689.4 6188.9 6269.0 6275.9 6289.4 6123.2 6153.4 6182.4 6195.9 6252.2 6007.4 6055.4 6114.5 6140.1 6142.6 5050.9 6139.3 6183.0 6254.1 6274.3 6067.1 6090.2 6110.3 6116.8 6127.1 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:66842.62 Median:39682.80 stddev:146097.35 (368.2%) stddev-sans-first:146422.25 09:03:26 INFO - PROCESS | 1647 | Values: 489.8 512.0 532.7 534.3 569.6 37386.8 39729.8 39765.8 39862.4 39881.0 40987.2 41379.3 41493.6 41602.0 41620.2 9598.5 9819.2 9823.7 9828.4 9838.5 7998.6 9779.0 9854.8 9922.0 9941.0 9822.0 9879.0 9885.5 9897.7 9947.4 9515.8 9827.1 9858.7 9876.9 9914.7 7443.9 9768.7 9769.2 9799.7 9806.5 38976.8 39088.0 39212.6 39357.8 39375.2 3297.0 3556.6 3658.0 3870.7 4349.9 30932.5 31577.4 31944.8 32050.2 32126.7 3225.3 3365.8 3402.2 3443.7 3457.2 307602.0 348007.0 373591.0 374193.0 376144.0 60322.7 60372.1 60747.7 60816.1 60930.4 62278.0 62732.7 62801.4 62848.4 62852.7 16034.4 16083.0 16246.9 16304.9 16334.0 12603.9 12642.6 12642.9 12671.9 12705.7 15313.9 16642.4 16675.9 16684.4 16812.3 5530.9 5617.5 6555.9 6595.0 6618.7 848.8 907.5 1039.0 1056.7 1067.9 26956.0 30539.1 30585.9 30717.7 30866.8 1045.7 1059.7 1167.6 1168.8 1212.5 15434.8 15872.9 15943.8 16207.0 16512.6 688219.0 694390.0 698593.0 700721.0 700876.0 58795.7 58999.1 59081.4 59452.0 59527.0 1302.7 1334.3 1352.5 1354.7 1356.2 25675.5 26816.9 27332.7 28479.4 30474.8 52337.0 52875.5 52942.0 52979.9 52999.0 500638.0 505616.0 505898.0 506982.0 616463.0 26678.6 26827.9 26916.6 26937.3 27006.0 47035.8 47453.3 48105.0 48275.8 48677.8 38858.8 39248.0 40036.2 40716.6 40768.0 38194.5 39748.2 40196.0 40977.9 41188.6 38327.8 38924.8 39270.2 39465.8 39635.8 34734.8 34979.1 35941.0 35948.6 36064.5 22859.8 25986.7 26444.3 26594.9 26983.7 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:35083.84 Median:4433.90 stddev:99292.99 (2239.4%) stddev-sans-first:99537.26 09:03:26 INFO - PROCESS | 1647 | Values: 335.5 359.7 367.6 373.9 394.0 18052.0 20099.1 20780.5 21556.6 21767.9 18958.4 19375.8 20265.9 21135.7 21347.1 5818.8 5947.8 6001.8 6039.0 6114.4 4143.8 5960.9 6054.8 6056.1 6097.4 6372.1 6655.9 6736.9 6761.9 6776.1 6628.4 6678.1 6729.1 6760.8 6774.3 5841.3 5841.3 5845.3 5846.2 5858.1 23823.5 25196.5 25814.7 25856.4 25935.2 1834.1 1986.6 2194.8 2447.5 2547.4 5654.7 8042.8 8395.5 10176.2 10443.7 1830.6 1832.6 1925.6 1936.4 1938.0 98534.0 122074.2 129865.0 130754.0 133122.0 9367.3 11015.6 11221.3 11243.8 11284.1 11456.5 14070.2 14139.2 14162.5 14192.6 6985.4 8233.8 8492.3 8570.8 8635.4 8348.7 8442.5 8456.7 8649.6 8655.1 3852.6 4408.6 4459.2 4474.6 4485.6 1544.9 1868.2 1934.4 1937.2 1939.4 801.4 820.8 841.3 912.7 1062.9 20654.8 21375.3 21466.2 21485.5 21581.9 731.3 884.2 925.9 952.8 955.2 10752.4 11154.0 11248.8 11250.4 11268.0 567170.0 590616.0 598224.0 599091.0 602795.0 135051.0 136998.0 139721.3 140855.0 141369.0 953.6 954.3 964.9 969.3 974.1 17747.6 18376.2 18607.0 19120.9 19375.7 37502.8 45457.0 55677.7 57586.7 58249.5 74475.6 74911.0 77016.6 80993.4 82169.0 7688.0 8016.4 8215.9 8248.6 8389.2 12026.5 13182.7 13322.9 13506.3 13522.7 8676.4 9177.4 9460.6 11617.9 11777.5 9535.7 11229.0 11447.0 11639.4 11674.5 10691.9 11418.5 11746.8 11767.5 11810.9 8016.9 8129.1 8156.6 8188.3 8239.5 7393.0 7409.8 7935.1 7961.5 8571.7 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5714.94 Median:4961.04 stddev:3196.69 (64.4%) stddev-sans-first:3189.39 09:03:26 INFO - PROCESS | 1647 | Values: 1423.9 1500.0 1692.2 1797.3 1861.4 8045.0 8566.3 8714.0 9129.0 9156.4 8702.0 8910.3 8928.8 8932.8 8937.1 2386.4 2409.2 2411.7 2418.4 2427.3 2374.5 2400.4 2417.7 2421.8 2425.3 2390.6 2400.7 2414.7 2418.8 2423.1 2376.7 2390.8 2398.8 2403.2 2403.6 2373.1 2380.4 2386.9 2393.9 2394.2 8854.8 8960.4 8962.1 8963.2 8996.8 5295.1 5403.9 5421.0 5429.9 5434.1 3599.3 3716.2 3743.1 3776.1 3788.1 1117.0 1134.6 1143.1 1153.7 1759.4 11524.9 11682.8 11807.1 11837.4 11843.2 4345.3 4617.9 4673.0 4698.7 4716.1 9074.0 9149.2 9162.1 9163.7 9174.4 5293.4 5303.2 5303.3 5308.6 5312.6 4289.3 4820.6 4942.4 4956.4 4991.5 3755.2 3821.6 3885.3 3900.4 3918.0 1006.7 1175.1 1187.0 1190.7 1193.1 924.7 937.3 937.5 945.3 973.5 4965.7 5487.8 6045.3 6065.7 6226.8 434.5 435.4 438.3 444.4 458.5 3945.9 4052.0 4071.9 4176.3 4185.7 10447.8 10884.8 10895.2 10906.5 10909.2 10813.9 10826.4 10832.9 10836.2 10857.1 7994.4 7995.5 8290.5 8323.0 8334.4 5840.0 5937.8 6008.5 6011.4 6021.5 7926.9 8999.2 9864.8 10153.5 10212.2 8427.7 10046.2 10354.4 10366.5 10415.5 6627.5 6896.4 7030.6 7120.4 7171.1 8618.4 8633.0 8664.2 8679.2 8690.3 7593.4 7697.5 7797.0 7820.4 7858.1 7436.6 7564.9 7583.4 7608.1 7706.6 7060.0 7202.4 7214.2 7220.6 7238.3 4976.9 4982.9 5078.8 5142.2 5263.3 3851.7 5075.0 5143.1 5234.4 5306.2 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4713.04 Median:5371.37 stddev:1457.46 (27.1%) stddev-sans-first:1423.36 09:03:26 INFO - PROCESS | 1647 | Values: 297.0 304.5 308.9 310.4 316.3 4558.7 5365.4 5648.7 5664.3 5692.9 5502.1 5511.5 5528.4 5554.9 5574.9 3769.5 4148.7 4156.3 4212.6 4236.9 4166.8 4187.4 4210.8 4234.5 4237.5 3470.6 4170.4 4182.1 4200.2 4241.8 4028.9 4162.6 4171.7 4217.3 4220.7 3052.6 3587.0 3617.6 3629.7 3645.4 5366.4 5368.8 5373.9 5382.1 5391.5 3536.3 4631.4 4752.2 4853.3 4853.3 5163.9 5780.9 5803.1 5879.7 5886.8 3996.9 4015.9 4022.6 4038.6 4053.7 5115.5 5711.3 5994.5 6061.2 6158.6 3621.2 3780.8 4038.7 4080.9 4103.6 3592.7 4070.9 4155.3 4172.2 4177.4 3981.5 4286.4 4798.6 4845.0 4853.9 5294.6 5821.3 5859.9 5878.4 5911.3 1231.6 1410.5 1417.4 1425.3 1433.5 805.3 861.0 868.6 874.5 896.2 5225.6 5227.7 5364.7 5377.4 5632.7 5942.7 6071.6 6129.4 6144.8 6157.5 5246.2 5492.9 5524.8 5538.6 5549.2 2895.2 3078.2 3167.3 3194.6 3223.5 5376.9 5679.8 6098.8 6369.0 6375.0 5674.8 5688.4 6011.5 6145.4 6189.8 5496.2 6336.5 6348.8 6368.6 6370.8 4733.4 4877.8 5172.8 5220.7 5850.7 4863.1 5050.7 5403.9 5606.7 5974.8 5552.9 5649.8 6078.4 6303.5 6331.8 3459.5 3668.4 3900.0 4076.3 4085.2 5316.1 5530.2 6060.4 6073.2 6084.8 5154.9 5167.3 5675.4 5897.4 5939.3 5556.5 5775.2 5804.0 5823.0 5892.3 5641.8 5748.4 5754.0 5758.0 5761.7 5324.7 5490.3 5523.8 5778.9 5811.8 5398.5 5401.5 5402.3 5471.6 5714.4 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:26577.90 Median:22081.50 stddev:44800.51 (202.9%) stddev-sans-first:44884.08 09:03:26 INFO - PROCESS | 1647 | Values: 706.7 717.9 720.6 770.9 818.3 14828.2 15845.9 15883.7 15884.9 15903.7 14451.5 14616.3 14627.1 14632.3 14634.5 677.7 820.7 848.5 853.9 860.8 854.5 854.8 855.6 860.0 860.5 920.5 923.8 924.2 925.6 928.0 909.3 910.8 914.0 914.4 918.0 670.1 680.9 682.9 683.7 684.1 10498.6 13817.4 14488.6 14522.2 14570.6 14197.4 14308.4 14448.2 14471.9 14536.9 11125.3 11262.7 11269.0 11417.3 11654.1 3784.5 3868.6 3874.9 3948.2 4014.3 99337.0 104455.5 104507.0 113591.0 115504.4 11083.4 11159.9 11237.4 11454.8 11656.1 22046.3 22051.1 22054.9 22078.6 22084.4 7989.3 8126.6 8158.2 8309.0 8324.4 4484.2 4571.4 4596.0 4738.6 4744.0 3382.5 3454.0 3506.5 3511.6 3521.1 652.8 654.5 655.1 671.0 677.2 573.0 605.5 644.6 674.2 678.9 9201.1 9365.6 9451.8 9662.3 10056.9 661.4 661.7 668.6 690.3 710.0 4296.9 4334.2 4634.9 4673.9 4701.9 167673.0 172915.0 174510.0 175376.0 182244.0 145286.0 147969.3 149038.0 149436.0 152700.0 123284.0 128291.0 128799.4 129338.0 130077.7 8179.0 8418.3 8495.4 8723.0 9021.3 58863.4 67643.0 68736.0 68990.0 69566.7 64781.0 91192.0 105564.0 105798.8 107310.9 12185.5 12349.3 12590.1 13028.3 13144.6 13163.8 13338.3 13351.6 13494.7 13721.6 12145.8 12415.1 12497.0 12515.5 12872.2 12556.8 12595.1 12731.1 12804.4 12869.2 10305.6 10648.9 11872.2 11942.8 12180.1 9597.9 10103.9 10245.9 10332.8 10526.4 10425.0 10719.0 10734.6 10857.3 10902.5 09:03:26 INFO - PROCESS | 1647 | -------- Summary: end -------- 09:03:26 INFO - PROCESS | 1647 | 09:03:26 INFO - TEST-INFO | 1647: exit 0 09:03:26 INFO - TEST-OK | dromaeo_css | took 1114328ms 09:03:26 INFO - TEST-START | kraken 09:03:26 INFO - operating with platform_type : mac_ 09:03:26 INFO - Initialising browser for kraken test... 09:03:26 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpU8R1Ad/profile http://localhost:49262/getInfo.html) 09:03:29 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 09:03:29 INFO - PROCESS | 1658 | colorDepth:24 09:03:29 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 09:03:29 INFO - PROCESS | 1658 | __metrics 09:03:29 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 09:03:30 INFO - TEST-INFO | 1658: exit 0 09:03:30 INFO - Browser initialized. 09:03:30 INFO - Running cycle 1/1 for kraken test... 09:03:30 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/T/tmpU8R1Ad/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:42 INFO - PROCESS | 1660 | RSS: Main: 244469760 09:03:42 INFO - PROCESS | 1660 | 09:03:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:46 INFO - PROCESS | 1660 | RSS: Main: 257212416 09:03:46 INFO - PROCESS | 1660 | 09:03:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 09:03:49 INFO - PROCESS | 1660 | RSS: Main: 265830400 09:03:49 INFO - PROCESS | 1660 | 09:03:52 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 09:03:53 INFO - PROCESS | 1660 | RSS: Main: 266739712 09:03:53 INFO - PROCESS | 1660 | 09:03:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 09:03:56 INFO - PROCESS | 1660 | RSS: Main: 268165120 09:03:56 INFO - PROCESS | 1660 | 09:03:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:58 INFO - PROCESS | 1660 | RSS: Main: 269795328 09:03:58 INFO - PROCESS | 1660 | 09:04:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:02 INFO - PROCESS | 1660 | RSS: Main: 270680064 09:04:02 INFO - PROCESS | 1660 | 09:04:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:06 INFO - PROCESS | 1660 | RSS: Main: 270860288 09:04:06 INFO - PROCESS | 1660 | 09:04:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 09:04:09 INFO - PROCESS | 1660 | RSS: Main: 270901248 09:04:09 INFO - PROCESS | 1660 | 09:04:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:12 INFO - PROCESS | 1660 | RSS: Main: 270827520 09:04:12 INFO - PROCESS | 1660 | 09:04:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:14 INFO - PROCESS | 1660 | RSS: Main: 270258176 09:04:14 INFO - PROCESS | 1660 | 09:04:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:17 INFO - PROCESS | 1660 | RSS: Main: 270495744 09:04:17 INFO - PROCESS | 1660 | 09:04:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:21 INFO - PROCESS | 1660 | RSS: Main: 270655488 09:04:21 INFO - PROCESS | 1660 | 09:04:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:25 INFO - PROCESS | 1660 | RSS: Main: 270860288 09:04:25 INFO - PROCESS | 1660 | 09:04:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 09:04:27 INFO - PROCESS | 1660 | RSS: Main: 273002496 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | __start_tp_report 09:04:27 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 09:04:27 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 09:04:27 INFO - PROCESS | 1660 | |i|pagename|runs| 09:04:27 INFO - PROCESS | 1660 | |0;ai-astar;109;115;117;115;118;114;110;117;116;134 09:04:27 INFO - PROCESS | 1660 | |1;audio-beat-detection;147;137;117;193;142;164;166;115;158;112 09:04:27 INFO - PROCESS | 1660 | |2;audio-dft;199;215;282;245;195;202;198;202;194;195 09:04:27 INFO - PROCESS | 1660 | |3;audio-fft;70;82;75;138;60;60;57;64;132;59 09:04:27 INFO - PROCESS | 1660 | |4;audio-oscillator;71;72;128;83;72;88;122;92;90;112 09:04:27 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;135;129;90;124;82;132;138;86;88;87 09:04:27 INFO - PROCESS | 1660 | |6;imaging-darkroom;99;100;99;116;94;169;135;100;101;99 09:04:27 INFO - PROCESS | 1660 | |7;imaging-desaturate;145;145;91;151;142;123;91;91;93;92 09:04:27 INFO - PROCESS | 1660 | |8;json-parse-financial;55;59;57;59;57;58;58;56;56;56 09:04:27 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;68;71;73;86;97;107;82;72;72;72 09:04:27 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;92;92;113;109;86;86;91;89;86;110 09:04:27 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;159;163;147;166;163;131;124;157;192;162 09:04:27 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;175;190;199;237;188;169;177;204;232;236 09:04:27 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;69;68;69;69;69;70;64;58;95 09:04:27 INFO - PROCESS | 1660 | __end_tp_report 09:04:27 INFO - PROCESS | 1660 | __start_cc_report 09:04:27 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,958 09:04:27 INFO - PROCESS | 1660 | __end_cc_report 09:04:27 INFO - PROCESS | 1660 | __startTimestamp1472227467190__endTimestamp 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | ------- Summary: start ------- 09:04:27 INFO - PROCESS | 1660 | Number of tests: 14 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.50 stddev:6.82 (5.9%) stddev-sans-first:6.67 09:04:27 INFO - PROCESS | 1660 | Values: 109.0 115.0 117.0 115.0 118.0 114.0 110.0 117.0 116.0 134.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.50 stddev:26.09 (17.1%) stddev-sans-first:27.66 09:04:27 INFO - PROCESS | 1660 | Values: 147.0 137.0 117.0 193.0 142.0 164.0 166.0 115.0 158.0 112.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:212.70 Median:202.00 stddev:28.79 (14.3%) stddev-sans-first:30.11 09:04:27 INFO - PROCESS | 1660 | Values: 199.0 215.0 282.0 245.0 195.0 202.0 198.0 202.0 194.0 195.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:79.70 Median:62.00 stddev:30.23 (48.8%) stddev-sans-first:31.85 09:04:27 INFO - PROCESS | 1660 | Values: 70.0 82.0 75.0 138.0 60.0 60.0 57.0 64.0 132.0 59.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:77.50 stddev:20.89 (27.0%) stddev-sans-first:20.59 09:04:27 INFO - PROCESS | 1660 | Values: 71.0 72.0 128.0 83.0 72.0 88.0 122.0 92.0 90.0 112.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:84.00 stddev:24.07 (28.7%) stddev-sans-first:23.64 09:04:27 INFO - PROCESS | 1660 | Values: 135.0 129.0 90.0 124.0 82.0 132.0 138.0 86.0 88.0 87.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:131.50 stddev:23.64 (18.0%) stddev-sans-first:24.65 09:04:27 INFO - PROCESS | 1660 | Values: 99.0 100.0 99.0 116.0 94.0 169.0 135.0 100.0 101.0 99.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:116.40 Median:91.00 stddev:27.10 (29.8%) stddev-sans-first:26.70 09:04:27 INFO - PROCESS | 1660 | Values: 145.0 145.0 91.0 151.0 142.0 123.0 91.0 91.0 93.0 92.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:1.37 (2.4%) stddev-sans-first:1.22 09:04:27 INFO - PROCESS | 1660 | Values: 55.0 59.0 57.0 59.0 57.0 58.0 58.0 56.0 56.0 56.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:72.50 stddev:13.01 (17.9%) stddev-sans-first:13.06 09:04:27 INFO - PROCESS | 1660 | Values: 68.0 71.0 73.0 86.0 97.0 107.0 82.0 72.0 72.0 72.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:87.50 stddev:10.83 (12.4%) stddev-sans-first:11.42 09:04:27 INFO - PROCESS | 1660 | Values: 92.0 92.0 113.0 109.0 86.0 86.0 91.0 89.0 86.0 110.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:162.50 stddev:19.06 (11.7%) stddev-sans-first:20.19 09:04:27 INFO - PROCESS | 1660 | Values: 159.0 163.0 147.0 166.0 163.0 131.0 124.0 157.0 192.0 162.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.70 Median:201.50 stddev:25.95 (12.9%) stddev-sans-first:25.80 09:04:27 INFO - PROCESS | 1660 | Values: 175.0 190.0 199.0 237.0 188.0 169.0 177.0 204.0 232.0 236.0 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.00 stddev:9.51 (13.8%) stddev-sans-first:10.08 09:04:27 INFO - PROCESS | 1660 | Values: 69.0 69.0 68.0 69.0 69.0 69.0 70.0 64.0 58.0 95.0 09:04:27 INFO - PROCESS | 1660 | -------- Summary: end -------- 09:04:27 INFO - PROCESS | 1660 | 09:04:27 INFO - TEST-INFO | 1660: exit 0 09:04:28 INFO - TEST-OK | kraken | took 61107ms 09:04:28 INFO - SUITE-END | took 1175s 09:04:28 INFO - Completed test suite (00:19:35) 09:04:28 INFO - javascript benchmark 09:04:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7387.309999451656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3432.365012472694, 3438.174838038871, 3464.497647841063, 3471.4098603237453, 3483.3729928612856, 5822.126680997852, 5833.5916485845955, 5874.471297583216, 5876.2948446186465, 5937.881242375161, 4418.491873434548, 5605.1872478490695, 5893.204417403649, 5945.583809133363, 5997.580169388145, 5239.685618862871, 5307.73461326934, 5386.91919621204, 5389.191621256823, 5394.433584473632, 5174.327337446127, 5270.367555893298, 5326.92009619856, 5357.249985002103, 5399.325084364455, 5304.38999515053, 5317.813876514323, 5321.0, 5375.301210842605, 5421.1326187810155, 5310.814121505768, 5323.441038690959, 5332.280142180794, 5339.012282727708, 5403.972980135113, 5142.408623008365, 5253.553447956928, 5291.444398338158, 5296.5762738981175, 5312.4687531246955, 4680.531946805327, 5677.545796336283, 5906.5570082244, 5914.349421563625, 6005.219321488178, 6176.536759743038, 6228.018611324244, 6242.344553821828, 6262.935300998795, 6273.529485288622, 6118.162361256311, 6239.438450539473, 6268.279147898004, 6286.559940804145, 6295.118683384329, 5928.288605367384, 5965.791197308074, 5998.970005149947, 6016.308124565688, 6062.514998800086, 6373.936260637334, 6446.806595802133, 6458.806235812933, 6463.612183269019, 6468.06213099098, 6131.50947924165, 6257.78097766576, 6264.780732674426, 6273.686315684197, 6277.811665650038, 6188.44304012641, 6214.658193799294, 6230.439260466489, 6283.6858157091965, 6299.716512756937, 6183.783567575203, 6280.152179455715, 6282.4974002079725, 6286.057091436322, 6291.591046582049, 5161.993411284839, 6202.751889924352, 6275.748970041239, 6289.496840252768, 6309.148264984168, 4979.153543897546, 5028.969061342416, 5030.094582975026, 5041.899162016739, 5083.135866902636, 3464.86140554375, 3602.765820221677, 3711.6473934976134, 4269.0, 4524.751138687404, 5658.264425624642, 5968.403159683997, 5987.970060149672, 6030.698465076816, 6047.183630209954, 6169.691515424211, 6170.976689524024, 6187.628742275388, 6271.27880293763, 6276.121343011982, 5914.053751399755, 5935.376785437467, 5943.673097979567, 5960.195373624592, 5978.4021597839865, 5425.430329815392, 5464.371597266286, 5465.0, 5477.3427188737605, 5495.230667706524, 6322.209723784527, 6394.328595497405, 6436.549441539048, 6459.192600924885, 6565.704543295467, 6280.591761535486, 6307.90538141919, 6313.684315784284, 6315.0, 6320.051992201023, 6496.382843629847, 6533.575317604341, 6559.508036897348, 6576.605403675795, 6577.835554111186, 6117.035835319669, 6219.0, 6219.533534984985, 6241.344658810941, 6297.2128483939505, 5397.8380648580605, 6274.090256912631, 6284.905726414199, 6287.30839607652, 6289.7169627365965, 5689.374168841341, 6188.907166392598, 6268.9969604863, 6275.937240627535, 6289.371062893674, 6123.234595675541, 6153.384661533811, 6182.381761823782, 6195.907061393992, 6252.249730032425, 6007.429294217042, 6055.364186760326, 6114.510839132769, 6140.109684095871, 6142.570020098729, 5050.949490505195, 6139.26328840542, 6183.0107182850525, 6254.061890716429, 6274.341194174546, 6067.119193050168, 6090.208272924491, 6110.327863935053, 6116.847078823065, 6127.080937859357], "value": 5756.033480073012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.8456986049395, 511.9718415487147, 532.7309708597159, 534.324080038751, 569.5557465177163, 37386.813065934664, 39729.80135099324, 39765.80702578924, 39862.402063969064, 39881.0, 40987.18025639485, 41379.3448212081, 41493.58506414935, 41602.0, 41620.16759664805, 9598.520073996307, 9819.165370943478, 9823.65617203398, 9828.36115652484, 9838.458884761336, 7998.640061197231, 9778.951105244463, 9854.802903941916, 9922.0, 9941.0, 9822.0, 9878.950605246964, 9885.505724713772, 9897.703068907944, 9947.353422027581, 9515.762105947337, 9827.066428689299, 9858.704238872846, 9876.851847222297, 9914.652987145488, 7443.925560744377, 9768.658096966572, 9769.169620582259, 9799.706008819747, 9806.460644664541, 38976.80511597452, 39088.0, 39212.60787392118, 39357.80321098376, 39375.21249575021, 3296.9602881979, 3556.6443355664487, 3657.963420365789, 3870.748401353903, 4349.913001739979, 30932.536011959837, 31577.368452630817, 31944.840275798706, 32050.19874503156, 32126.678733212604, 3225.3226822367096, 3365.764396492222, 3402.183475965775, 3443.6900678939014, 3457.2048428861503, 307602.0, 348007.0, 373591.0, 374193.0, 376144.0, 60322.698386507785, 60372.09441858376, 60747.69626151841, 60816.08775868366, 60930.39069609247, 62278.0, 62732.686336568026, 62801.371986280465, 62848.371516285166, 62852.68573657194, 16034.438794642365, 16083.035017898963, 16246.918765406097, 16304.918475407547, 16334.0, 12603.936980315224, 12642.620721378373, 12642.873571264354, 12671.936640316739, 12705.745885082246, 15313.923430382776, 16642.417515386904, 16675.91662041682, 16684.416045438593, 16812.327506899586, 5530.944690553123, 5617.494425501724, 6555.901661475082, 6594.9670251649395, 6618.735250590019, 848.779317377474, 907.4872696926216, 1038.981797838123, 1056.6882769582837, 1067.9252452328262, 26956.0, 30539.08382748521, 30585.929492467658, 30717.657181794555, 30866.76532938702, 1045.72288343589, 1059.660908509285, 1167.6205233299042, 1168.7954607943575, 1212.5210541836102, 15434.845651543565, 15872.888897777044, 15943.760843587355, 16207.0, 16512.587185320463, 688219.0, 694390.0, 698593.0, 700721.0, 700876.0, 58795.706021470476, 58999.11501327484, 59081.40918590845, 59452.0, 59527.0, 1302.6743314171458, 1334.3461703765279, 1352.5266156845025, 1354.7290541891857, 1356.1727346318935, 25675.459472431714, 26816.865915670296, 27332.726672733814, 28479.43041139207, 30474.84762576173, 52337.0, 52875.47124528705, 52942.0, 52979.94040119099, 52999.0, 500638.0, 505616.0, 505898.0, 506982.0, 616463.0, 26678.59982100309, 26827.926882925247, 26916.596251055857, 26937.326566835203, 27006.0, 47035.764821175675, 47453.288200676325, 48105.0, 48275.75862120667, 48677.75661121672, 38858.80570597129, 39248.0, 40036.19927601374, 40716.59283407128, 40768.0, 38194.506933821875, 39748.20503589854, 40196.0, 40977.85332200194, 41188.58811411847, 38327.80836095801, 38924.80537597294, 39270.214595708494, 39465.802670986464, 39635.80182099071, 34734.826325868205, 34979.12552186216, 35941.0, 35948.64051359453, 36064.459033114, 22859.788978902685, 25986.740132598432, 26444.338891527867, 26594.86702566475, 26983.73016269812], "value": 19865.589461045154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.5252317970072, 359.73559433816143, 367.5846293688133, 373.94203898395756, 393.99531195451607, 18052.0, 20099.095540700666, 20780.48048798779, 21556.56886862264, 21767.891160544175, 18958.431247062577, 19375.806241937575, 20265.898670506627, 21135.682964755542, 21347.146114155454, 5818.796342128037, 5947.791827286046, 6001.819945401623, 6038.96980515099, 6114.419130182648, 4143.813528391214, 5960.88078238435, 6054.8183554493435, 6056.061310496858, 6097.420745029215, 6372.107904893319, 6655.866882662343, 6736.932630673704, 6761.898571521431, 6776.085228494139, 6628.426385793787, 6678.098456708331, 6729.05793188954, 6760.8309792255095, 6774.322567743236, 5841.328247251536, 5841.3282472515775, 5845.269341332333, 5846.239988801472, 5858.12128180772, 23823.49853265417, 25196.496070078494, 25814.74185258161, 25856.353591160372, 25935.22194334173, 1834.1471215884678, 1986.5927484865567, 2194.7709282801684, 2447.49826285611, 2547.3631592101974, 5654.74553645087, 8042.798930026737, 8395.538245396501, 10176.16828970785, 10443.738906527322, 1830.6247219320007, 1832.5876677747533, 1925.5859990102194, 1936.4093951344835, 1937.9612407751765, 98534.0, 122074.16888746676, 129865.0, 130754.0, 133122.0, 9367.250619950388, 11015.614453494089, 11221.270617410006, 11243.775124497464, 11284.097272218203, 11456.54173833054, 14070.226137562327, 14139.151650900978, 14162.504312349018, 14192.645183870485, 6985.406240469617, 8233.752987410388, 8492.278156356655, 8570.785730356667, 8635.352348573882, 8348.707795227137, 8442.451240669337, 8456.704015359433, 8649.610767515476, 8655.091215422415, 3852.556955950102, 4408.603225709701, 4459.1973444779605, 4474.619657329098, 4485.618722408632, 1544.90730556167, 1868.168664944114, 1934.3713293179774, 1937.2347922570507, 1939.3697048459308, 801.3949468151508, 820.7865954851662, 841.2765022081005, 912.7085174478171, 1062.8512008318842, 20654.793452065285, 21375.251866184608, 21466.24868129608, 21485.462863428227, 21581.89209053976, 731.3271789953255, 884.2351366068433, 925.9166674999283, 952.7903861150675, 955.2358113509165, 10752.354858708502, 11153.996140347408, 11248.831267530994, 11250.381229032482, 11268.042216411697, 567170.0, 590616.0, 598224.0, 599091.0, 602795.0, 135051.0, 136998.0, 139721.30139349238, 140855.0, 141369.0, 953.5565961827783, 954.3081266082035, 964.8986856380119, 969.3021024862088, 974.055166488505, 17747.556311092325, 18376.173072211513, 18606.976616286232, 19120.852748835114, 19375.709364359263, 37502.81248593739, 45457.0, 55677.72161139168, 57586.7120664394, 58249.54376140461, 74475.62762186154, 74911.0, 77016.61491692506, 80993.3801323982, 82169.0, 7688.0, 8016.358691304798, 8215.917840821516, 8248.556502612139, 8389.244967952913, 12026.518939242333, 13182.670433239246, 13322.933385333012, 13506.257155856521, 13522.729545409233, 8676.440450067372, 9177.449353038839, 9460.621575136918, 11617.941910290394, 11777.470013849226, 9535.666251681158, 11229.0, 11447.027002704863, 11639.359835209145, 11674.533018679498, 10691.893081069089, 11418.486168122621, 11746.765064698488, 11767.52929882795, 11810.940945295219, 8016.8797468036855, 8129.065157506962, 8156.551389673625, 8188.344932405513, 8239.546824924686, 7393.0, 7409.777706668809, 7935.0874649413745, 7961.482503637245, 8571.657133714582], "value": 9424.646510935956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.864732850379, 1500.0474698566413, 1692.1708362902182, 1797.2900704221825, 1861.3857427049074, 8044.959775201116, 8566.271866891313, 8714.0, 9128.995810460843, 9156.404833685805, 8702.0, 8910.287177025839, 8928.776780580489, 8932.776680582989, 8937.061608531109, 2386.4272574582105, 2409.2170044735444, 2411.6503107049557, 2418.443757935676, 2427.3324835670155, 2374.536965291769, 2400.4478969836946, 2417.7098748150247, 2421.806255499556, 2425.2845410603827, 2390.605550084234, 2400.687910571632, 2414.6860908082012, 2418.830681852271, 2423.0550085466684, 2376.6791483149727, 2390.760923907613, 2398.8080953523677, 2403.242978461779, 2403.615421532555, 2373.1456675596773, 2380.4405964598304, 2386.916457923982, 2393.868337241451, 2394.185976767907, 8854.778630534223, 8960.372773905829, 8962.058983806672, 8963.193312601832, 8996.77508062297, 5295.099833028395, 5403.864903377408, 5420.972895135538, 5429.945700542983, 5434.076207044812, 3599.3341231872187, 3716.2195938852874, 3743.12036671382, 3776.131489757344, 3788.052986753312, 1116.9888301117048, 1134.6482590397004, 1143.0741099709178, 1153.6712037069478, 1759.375421725282, 11524.942375288154, 11682.831716828248, 11807.114466414967, 11837.408129593487, 11843.170978031541, 4345.326474396474, 4617.907641847211, 4673.0, 4698.718076915396, 4716.080364328923, 9074.001859795417, 9149.176574108229, 9162.129597688208, 9163.679271225476, 9174.357794954289, 5293.417724050351, 5303.15149576066, 5303.310569625924, 5308.628396012319, 5312.601554883399, 4289.335153051282, 4820.6143508519235, 4942.382202224722, 4956.430010548761, 4991.525805048587, 3755.1738617504107, 3821.617838216156, 3885.2618002579984, 3900.3759398496104, 3918.0, 1006.6929586476195, 1175.0893057880212, 1186.9762604747857, 1190.6963724250434, 1193.1230545549015, 924.6856068936594, 937.3485427627869, 937.5312343828086, 945.2532499325594, 973.464594473037, 4965.652404331662, 5487.807926722546, 6045.304789949212, 6065.727042283108, 6226.750929962841, 434.50032462667554, 435.3948012262957, 438.31622668637027, 444.36234004203425, 458.5071048622744, 3945.861894833667, 4052.0, 4071.918561628751, 4176.331786914079, 4185.727927684691, 10447.805960748175, 10884.782304353868, 10895.182861285435, 10906.5092070857, 10909.18181136402, 10813.945930270298, 10826.404547749791, 10832.945835270773, 10836.187285953585, 10857.077148442313, 7994.440389172702, 7995.480293780885, 8290.544020078833, 8322.958385208036, 8334.374921880883, 5840.0, 5937.792177273947, 6008.489278411384, 6011.398860113954, 6021.518278537619, 7926.881096783668, 8999.235065019546, 9864.753381165528, 10153.54309056109, 10212.234082443698, 8427.705030323908, 10046.246531510313, 10354.430506322225, 10366.533505992098, 10415.479226038819, 6627.469802415699, 6896.413804826646, 7030.648467576703, 7120.430365570845, 7171.103612048494, 8618.353623478139, 8633.0, 8664.220220180214, 8679.17547832955, 8690.304775618062, 7593.430492712958, 7697.461177717506, 7796.961015195115, 7820.3743700504965, 7858.096318923397, 7436.553806771611, 7564.886526701994, 7583.393328533593, 7608.125065617303, 7706.576138312446, 7059.964700176466, 7202.423806095395, 7214.242504536948, 7220.638968051681, 7238.348548630648, 4976.8755781105765, 4982.928670335895, 5078.847634570969, 5142.1772516397195, 5263.315768950012, 3851.691864650877, 5075.0, 5143.0999575073465, 5234.424213336606, 5306.177542480922], "value": 4536.183135702223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9709955005904, 304.47782053777775, 308.86718710954295, 310.44275525431846, 316.32622514045096, 4558.749268790223, 5365.444021233842, 5648.700798816275, 5664.2636457260605, 5692.9146062809095, 5502.119660854264, 5511.476409741068, 5528.419515950827, 5554.944450555503, 5574.888502229963, 3769.54765428149, 4148.738937279175, 4156.314208155651, 4212.599803018708, 4236.915261694764, 4166.83332666693, 4187.392828039932, 4210.831421817767, 4234.470691163605, 4237.453329534713, 3470.6008808986912, 4170.39529268256, 4182.051653584231, 4200.222958752625, 4241.791089539482, 4028.8992775180564, 4162.562930892243, 4171.728837625545, 4217.304144816102, 4220.7256528325715, 3052.5958059292752, 3587.031501494608, 3617.6382361763876, 3629.7277704172293, 3645.38028535147, 5366.436524164985, 5368.785248590052, 5373.946260537384, 5382.085045542267, 5391.541718953894, 3536.3104194682046, 4631.3516107744945, 4752.19416621685, 4853.252828981564, 4853.344798452199, 5163.922541161848, 5780.855478613026, 5803.129530570448, 5879.67661778602, 5886.7939622113445, 3996.9400458993136, 4015.875554844619, 4022.6379625833524, 4038.6365227129404, 4053.716239863211, 5115.514026167545, 5711.314642242957, 5994.482317426691, 6061.151438798572, 6158.630482171039, 3621.1713084891962, 3780.8487660493274, 4038.676905847525, 4080.8571699990357, 4103.610157035077, 3592.694620957248, 4070.900856768715, 4155.252054630196, 4172.207280616673, 4177.373393990925, 3981.5023122109737, 4286.357046443059, 4798.568128868418, 4844.95155048452, 4853.912817488514, 5294.57643388528, 5821.253623912809, 5859.853503662443, 5878.353381128072, 5911.261092363455, 1231.5566396097397, 1410.5274732964572, 1417.4471955937192, 1425.308725268244, 1433.4982756035304, 805.295366554265, 860.9870851937226, 868.5700578213824, 874.510274246424, 896.2023798819056, 5225.555827754683, 5227.712475813867, 5364.658835291178, 5377.435369286169, 5632.718364081861, 5942.741758131882, 6071.635701857903, 6129.448349648553, 6144.832481828438, 6157.538184636171, 5246.186841039645, 5492.917606235909, 5524.751386187631, 5538.584606154554, 5549.195366671891, 2895.1604034830084, 3078.1688943985, 3167.334859679493, 3194.584703988513, 3223.5487031815564, 5376.892462150735, 5679.750454899915, 6098.817035488943, 6368.980963045983, 6374.9681251594375, 5674.801381951612, 5688.431156884279, 6011.549133814894, 6145.4161854623735, 6189.752409903644, 5496.169472721552, 6336.483251795205, 6348.77779277723, 6368.64972426521, 6370.8088757337355, 4733.414306207322, 4877.805087624569, 5172.793088276427, 5220.728982892454, 5850.736716847837, 4863.051704917649, 5050.671706339076, 5403.945960540502, 5606.6916319602815, 5974.790882319098, 5552.918604825531, 5649.802256920988, 6078.422549857756, 6303.495720342454, 6331.841703957438, 3459.4983727359895, 3668.358037343401, 3899.9610003900734, 4076.3477843544892, 4085.22380747657, 5316.069687804541, 5530.225768392509, 6060.393960603904, 6073.240844894388, 6084.847878803065, 5154.891698284887, 5167.250748641351, 5675.4040825714355, 5897.3807750185615, 5939.2575928009, 5556.472135147154, 5775.249217601853, 5803.970980145073, 5823.0, 5892.263467066617, 5641.830745077655, 5748.425157484218, 5753.971230143822, 5758.0, 5761.683107428964, 5324.733763311741, 5490.286262785812, 5523.834284971457, 5778.942210578009, 5811.767529298781, 5398.54366263357, 5401.4868587484125, 5402.324709411324, 5471.644343117685, 5714.428557144252], "value": 4240.036057058799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.713780918728, 717.8564287142573, 720.6468830273166, 770.8882212079249, 818.341235305579, 14828.184449855267, 15845.89078764487, 15883.682326353466, 15884.920575397122, 15903.68192636148, 14451.494197703083, 14616.269186540658, 14627.122372657648, 14632.268386580656, 14634.48779292725, 677.6543962579083, 820.659426338069, 848.5417874347876, 853.9231469167773, 860.8192279621287, 854.5129276312505, 854.7820305822007, 855.5807654249435, 859.9699010534632, 860.4708104515709, 920.5351297594706, 923.833709932212, 924.2005665099707, 925.5927391947555, 928.0, 909.2544113826665, 910.7905181808221, 913.9771505712343, 914.4193437167446, 918.0452329577232, 670.058567712365, 680.884249677556, 682.8668409660119, 683.704380199524, 684.0594182998377, 10498.580056797718, 13817.447302108005, 14488.565343039725, 14522.201278929655, 14570.635734106627, 14197.432102715879, 14308.356123974447, 14448.205348705817, 14471.855281447157, 14536.92731536346, 11125.27685700435, 11262.662120136409, 11269.0, 11417.257878237888, 11654.125940554492, 3784.4512545680723, 3868.6324799144036, 3874.8837534874, 3948.2498325318097, 4014.297497937849, 99337.0, 104455.47772261166, 104507.0, 113590.99999999917, 115504.42247788707, 11083.445827708581, 11159.944200278947, 11237.381943992996, 11454.828177577343, 11656.125790565571, 22046.33860984173, 22051.11795528161, 22054.89725513718, 22078.558428831333, 22084.447888802908, 7989.280964713087, 8126.553039582762, 8158.184181581794, 8309.0, 8324.417290789708, 4484.170428470743, 4571.405717256735, 4595.954040459619, 4738.64460165489, 4743.976280118577, 3382.475716263983, 3453.9827300863335, 3506.5441492605796, 3511.648835116468, 3521.084518025332, 652.8204743695521, 654.502578040683, 655.0698008827381, 670.9765158219438, 677.2482544375739, 572.9799457018985, 605.479287812481, 644.6486664767713, 674.2145400608334, 678.8574399376088, 9201.125893040151, 9365.62537498506, 9451.763705907408, 9662.323637345458, 10056.892996447206, 661.4278648968608, 661.6948343026517, 668.6217588906395, 690.2786588015535, 709.9964500177466, 4296.892577685583, 4334.1981733379425, 4634.884127896829, 4673.859784206479, 4701.858944231679, 167673.0, 172915.0, 174510.0, 175376.0, 182244.0, 145286.0, 147969.26015370068, 149038.0, 149436.0, 152700.0, 123284.0, 128291.0, 128799.35600322126, 129338.0, 130077.69922300846, 8178.9591052046735, 8418.326533877398, 8495.362847786564, 8723.040465548658, 9021.323400745101, 58863.41136588579, 67643.0, 68735.96896046663, 68990.0, 69566.65216673884, 64781.0, 91192.0, 105564.0, 105798.82603521907, 107310.92689073322, 12185.51257949672, 12349.32078735678, 12590.11869169186, 13028.348582570645, 13144.60566183016, 13163.802542961672, 13338.26639534796, 13351.599452016066, 13494.662633434242, 13721.588352349445, 12145.757084858431, 12415.068869834618, 12497.0, 12515.499380024698, 12872.22766634005, 12556.754819181415, 12595.118341715992, 12731.108822382344, 12804.423800928795, 12869.163504372185, 10305.58293753923, 10648.935106489598, 11872.168948173545, 11942.820857687315, 12180.147389682637, 9597.9040209597, 10103.949480252551, 10245.897541024793, 10332.845007324746, 10526.421046842192, 10425.0, 10719.0, 10734.570617175537, 10857.294275872044, 10902.50938707776], "value": 7840.139152718375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1643.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 117.0, 115.0, 118.0, 114.0, 110.0, 117.0, 116.0, 134.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 137.0, 117.0, 193.0, 142.0, 164.0, 166.0, 115.0, 158.0, 112.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 215.0, 282.0, 245.0, 195.0, 202.0, 198.0, 202.0, 194.0, 195.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 75.0, 138.0, 60.0, 60.0, 57.0, 64.0, 132.0, 59.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 128.0, 83.0, 72.0, 88.0, 122.0, 92.0, 90.0, 112.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 90.0, 124.0, 82.0, 132.0, 138.0, 86.0, 88.0, 87.0], "value": 109.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 99.0, 116.0, 94.0, 169.0, 135.0, 100.0, 101.0, 99.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 91.0, 151.0, 142.0, 123.0, 91.0, 91.0, 93.0, 92.0], "value": 116.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 57.0, 59.0, 57.0, 58.0, 58.0, 56.0, 56.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 73.0, 86.0, 97.0, 107.0, 82.0, 72.0, 72.0, 72.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 113.0, 109.0, 86.0, 86.0, 91.0, 89.0, 86.0, 110.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 147.0, 166.0, 163.0, 131.0, 124.0, 157.0, 192.0, 162.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 190.0, 199.0, 237.0, 188.0, 169.0, 177.0, 204.0, 232.0, 236.0], "value": 200.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 64.0, 58.0, 95.0], "value": 70.0, "unit": "score"}]}]} 09:04:28 INFO - Return code: 0 09:04:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:04:28 ERROR - # TBPL SUCCESS # 09:04:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:04:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:04:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:04:28 INFO - 2016-08-26 09:04:28.474 screenresolution[1665:10403] starting screenresolution argv=screenresolution get 09:04:28 INFO - 2016-08-26 09:04:28.477 screenresolution[1665:10403] Display 0: 1600x1200x32@60 09:04:28 INFO - 2016-08-26 09:04:28.484 screenresolution[1666:10406] starting screenresolution argv=screenresolution list 09:04:28 INFO - Available Modes on Display 0 09:04:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:04:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:04:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:04:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:04:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:04:28 INFO - Intel Iris: 09:04:28 INFO - Chipset Model: Intel Iris 09:04:28 INFO - Type: GPU 09:04:28 INFO - Bus: Built-In 09:04:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:04:28 INFO - Vendor: Intel (0x8086) 09:04:28 INFO - Device ID: 0x0a2e 09:04:28 INFO - Revision ID: 0x0009 09:04:28 INFO - Displays: 09:04:28 INFO - Display: 09:04:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:04:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:04:28 INFO - Display Serial Number: 1600x1200 60 09:04:28 INFO - Main Display: Yes 09:04:28 INFO - Mirror: Off 09:04:28 INFO - Online: Yes 09:04:28 INFO - Rotation: Supported 09:04:28 INFO - Return code: 0 09:04:28 INFO - Running post-action listener: _resource_record_post_action 09:04:28 INFO - [mozharness: 2016-08-26 16:04:28.720324Z] Finished run-tests step (success) 09:04:28 INFO - Running post-run listener: _resource_record_post_run 09:04:28 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37184512; Write bytes: 704343040; Read time: 238; Write time: 1944 09:04:28 INFO - TinderboxPrint: CPU usage
54.6% 09:04:28 INFO - TinderboxPrint: I/O read bytes / time
37,184,512 / 238 09:04:28 INFO - TinderboxPrint: I/O write bytes / time
704,343,040 / 1,944 09:04:28 INFO - TinderboxPrint: CPU idle
2,200.0 (45.4%) 09:04:28 INFO - TinderboxPrint: CPU system
979.9 (20.2%) 09:04:28 INFO - TinderboxPrint: CPU user
1,661.8 (34.3%) 09:04:28 INFO - TinderboxPrint: Swap in / out
444,051,456 / 0 09:04:28 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397615616; Write bytes: 391739392; Read time: 29514; Write time: 761 09:04:28 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 35251200; Write bytes: 293942272; Read time: 220; Write time: 1135 09:04:29 INFO - Running post-run listener: _upload_blobber_files 09:04:29 INFO - Blob upload gear active. 09:04:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:29 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 09:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:04:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:04:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:30 INFO - (blobuploader) - INFO - Done attempting. 09:04:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:04:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:31 INFO - (blobuploader) - INFO - Done attempting. 09:04:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:34 INFO - (blobuploader) - INFO - Done attempting. 09:04:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:34 INFO - Return code: 0 09:04:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11dd27ee97965256d62476d91268a9fc5d61e5d40df4035686f2086d1c64e90c0f22d6500dbbfd339ace36d77fdaaf1268aef69d51881d28ee2a8725a5c87e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b3249486fab963942f473504a99c55bbf9b536bf77f83d4eca34670b86e05d387bee050a60f47ba138afd6be1f69f9b391b277a32040d18c83d4bfebfbc71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76a21e85b0611d87275d63c56bb7b617fffe1a36702b4173a1e52e0322eb5040ade2b01bd9a41b1976ce152b4bfbc3796900342f7ca978c1a78cf4ddb74a3dbc"} 09:04:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:34 INFO - Contents: 09:04:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11dd27ee97965256d62476d91268a9fc5d61e5d40df4035686f2086d1c64e90c0f22d6500dbbfd339ace36d77fdaaf1268aef69d51881d28ee2a8725a5c87e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b3249486fab963942f473504a99c55bbf9b536bf77f83d4eca34670b86e05d387bee050a60f47ba138afd6be1f69f9b391b277a32040d18c83d4bfebfbc71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76a21e85b0611d87275d63c56bb7b617fffe1a36702b4173a1e52e0322eb5040ade2b01bd9a41b1976ce152b4bfbc3796900342f7ca978c1a78cf4ddb74a3dbc"} 09:04:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:34 INFO - Copying logs to upload dir... 09:04:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.050043 ========= master_lag: 26.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-08-26 09:05:01.439394) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-26 09:05:01.445341) ========= 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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11dd27ee97965256d62476d91268a9fc5d61e5d40df4035686f2086d1c64e90c0f22d6500dbbfd339ace36d77fdaaf1268aef69d51881d28ee2a8725a5c87e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b3249486fab963942f473504a99c55bbf9b536bf77f83d4eca34670b86e05d387bee050a60f47ba138afd6be1f69f9b391b277a32040d18c83d4bfebfbc71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76a21e85b0611d87275d63c56bb7b617fffe1a36702b4173a1e52e0322eb5040ade2b01bd9a41b1976ce152b4bfbc3796900342f7ca978c1a78cf4ddb74a3dbc"} build_url:https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011912 build_url: 'https://queue.taskcluster.net/v1/task/BwerARjgTfOqYK6utmpglA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11dd27ee97965256d62476d91268a9fc5d61e5d40df4035686f2086d1c64e90c0f22d6500dbbfd339ace36d77fdaaf1268aef69d51881d28ee2a8725a5c87e0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa9b3249486fab963942f473504a99c55bbf9b536bf77f83d4eca34670b86e05d387bee050a60f47ba138afd6be1f69f9b391b277a32040d18c83d4bfebfbc71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76a21e85b0611d87275d63c56bb7b617fffe1a36702b4173a1e52e0322eb5040ade2b01bd9a41b1976ce152b4bfbc3796900342f7ca978c1a78cf4ddb74a3dbc"}' ========= master_lag: 1.76 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-26 09:05:03.219580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-08-26 09:05:03.219865) ========= 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.kCgrYWXUQY/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.cXcTAp7zvK/Listeners TMPDIR=/var/folders/92/0ntvqzfn73q7gppwvgdzq_h400000w/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.005356 ========= master_lag: 5.84 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-08-26 09:05:09.069011) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-08-26 09:05:09.069463) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-08-26 09:05:12.417691) ========= ========= Total master_lag: 34.17 =========